builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0126 starttime: 1467140463.6 results: success (0) buildid: 20160628105123 builduid: a556123d04f249b1a95517ea0dd1b2c0 revision: cf85e0aa283eaaa522ddbc2749945ea97f249933 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 12:01:03.601299) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 12:01:03.601682) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 12:01:03.602116) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 12:01:03.625445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:01:03.625779) ========= 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.m8kvtV10Ln/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.eukJFkQtVK/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-28 12:01:03-- 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% 223M=0s 2016-06-28 12:01:04 (223 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.495267 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:01:04.421783) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:01:04.422111) ========= 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.m8kvtV10Ln/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.eukJFkQtVK/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.028531 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:01:04.487627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-06-28 12:01:04.487937) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cf85e0aa283eaaa522ddbc2749945ea97f249933 --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 cf85e0aa283eaaa522ddbc2749945ea97f249933 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m8kvtV10Ln/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.eukJFkQtVK/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-28 12:01:04,560 truncating revision to first 12 chars 2016-06-28 12:01:04,560 Setting DEBUG logging. 2016-06-28 12:01:04,561 attempt 1/10 2016-06-28 12:01:04,561 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cf85e0aa283e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 12:01:05,527 unpacking tar archive at: mozilla-beta-cf85e0aa283e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.240017 ========= master_lag: 1.80 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-06-28 12:01:07.528204) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 12:01:07.528502) ========= script_repo_revision: cf85e0aa283eaaa522ddbc2749945ea97f249933 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 12:01:07.528916) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 12:01:07.532235) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 12:01:07.743453) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 48 secs) (at 2016-06-28 12:01:07.743732) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.m8kvtV10Ln/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.eukJFkQtVK/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 12:01:08 INFO - MultiFileLogger online at 20160628 12:01:08 in /builds/slave/test 12:01:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:01:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:01:08 INFO - {'append_to_log': False, 12:01:08 INFO - 'base_work_dir': '/builds/slave/test', 12:01:08 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:01:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:01:08 INFO - 'branch': 'Mozilla-Beta', 12:01:08 INFO - 'buildbot_json_path': 'buildprops.json', 12:01:08 INFO - 'config_files': ('talos/mac_config.py',), 12:01:08 INFO - 'default_actions': ('clobber', 12:01:08 INFO - 'read-buildbot-config', 12:01:08 INFO - 'download-and-extract', 12:01:08 INFO - 'populate-webroot', 12:01:08 INFO - 'create-virtualenv', 12:01:08 INFO - 'install', 12:01:08 INFO - 'run-tests'), 12:01:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:01:08 INFO - 'download_minidump_stackwalk': True, 12:01:08 INFO - 'download_symbols': 'ondemand', 12:01:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:01:08 INFO - 'tooltool.py': '/tools/tooltool.py', 12:01:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:01:08 INFO - '/tools/misc-python/virtualenv.py')}, 12:01:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:01:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:01:08 INFO - 'installer_path': 'installer.exe', 12:01:08 INFO - 'log_level': 'info', 12:01:08 INFO - 'log_name': 'talos', 12:01:08 INFO - 'log_to_console': True, 12:01:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:01:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:01:08 INFO - 'opt_config_files': (), 12:01:08 INFO - 'pip_index': False, 12:01:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:01:08 INFO - 'cmd': ('bash', 12:01:08 INFO - '-c', 12:01:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:01:08 INFO - 'enabled': True, 12:01:08 INFO - 'halt_on_failure': False, 12:01:08 INFO - 'name': 'check_screen_resolution'},), 12:01:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:01:08 INFO - 'cmd': ('bash', 12:01:08 INFO - '-c', 12:01:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:01:08 INFO - 'enabled': True, 12:01:08 INFO - 'halt_on_failure': False, 12:01:08 INFO - 'name': 'check_screen_resolution'},), 12:01:08 INFO - 'run_cmd_checks_enabled': True, 12:01:08 INFO - 'sps_profile': False, 12:01:08 INFO - 'sps_profile_interval': 0, 12:01:08 INFO - 'suite': 'dromaeojs-e10s', 12:01:08 INFO - 'system_bits': '32', 12:01:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:01:08 INFO - 'title': 't-yosemite-r7-0126', 12:01:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:01:08 INFO - 'use_talos_json': True, 12:01:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:01:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:01:08 INFO - 'work_dir': 'build'} 12:01:08 INFO - ##### 12:01:08 INFO - ##### Running clobber step. 12:01:08 INFO - ##### 12:01:08 INFO - Running pre-action listener: _resource_record_pre_action 12:01:08 INFO - Running main action method: clobber 12:01:08 INFO - rmtree: /builds/slave/test/build 12:01:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:01:10 INFO - Running post-action listener: _resource_record_post_action 12:01:10 INFO - ##### 12:01:10 INFO - ##### Running read-buildbot-config step. 12:01:10 INFO - ##### 12:01:10 INFO - Running pre-action listener: _resource_record_pre_action 12:01:10 INFO - Running main action method: read_buildbot_config 12:01:10 INFO - Using buildbot properties: 12:01:10 INFO - { 12:01:10 INFO - "project": "", 12:01:10 INFO - "product": "firefox", 12:01:10 INFO - "script_repo_revision": "production", 12:01:10 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 12:01:10 INFO - "repository": "", 12:01:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 12:01:10 INFO - "buildid": "20160628105123", 12:01:10 INFO - "pgo_build": "False", 12:01:10 INFO - "basedir": "/builds/slave/test", 12:01:10 INFO - "buildnumber": 46, 12:01:10 INFO - "slavename": "t-yosemite-r7-0126", 12:01:10 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:01:10 INFO - "platform": "yosemite_r7", 12:01:10 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:01:10 INFO - "branch": "mozilla-beta", 12:01:10 INFO - "repo_path": "releases/mozilla-beta", 12:01:10 INFO - "revision": "cf85e0aa283eaaa522ddbc2749945ea97f249933", 12:01:10 INFO - "stage_platform": "macosx64", 12:01:10 INFO - "builduid": "a556123d04f249b1a95517ea0dd1b2c0", 12:01:10 INFO - "slavebuilddir": "test" 12:01:10 INFO - } 12:01:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 12:01:10 INFO - Running post-action listener: _resource_record_post_action 12:01:10 INFO - ##### 12:01:10 INFO - ##### Running download-and-extract step. 12:01:10 INFO - ##### 12:01:10 INFO - Running pre-action listener: _resource_record_pre_action 12:01:10 INFO - Running main action method: download_and_extract 12:01:10 INFO - mkdir: /builds/slave/test/build/tests 12:01:10 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')]} 12:01:10 INFO - https://queue.taskcluster.net/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:01:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 12:01:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 12:01:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/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 12:01:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/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 12:01:25 INFO - Downloaded 1165 bytes. 12:01:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 12:01:25 INFO - Using the following test package requirements: 12:01:25 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 12:01:25 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:01:25 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 12:01:25 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:01:25 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 12:01:25 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:01:25 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:01:25 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 12:01:25 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 12:01:25 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:01:25 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 12:01:25 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:01:25 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 12:01:25 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:01:25 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 12:01:25 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:01:25 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 12:01:25 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 12:01:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:25 INFO - https://queue.taskcluster.net/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:01:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 12:01:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 12:01:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/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 12:01:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/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 12:01:37 INFO - Downloaded 18350340 bytes. 12:01:37 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'] 12:01:37 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 12:01:40 INFO - Return code: 0 12:01:40 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 12:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:40 INFO - https://queue.taskcluster.net/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:01:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 12:01:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 12:01:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/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 12:01:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/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 12:01:42 INFO - Downloaded 18350340 bytes. 12:01:42 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'] 12:01:42 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 12:01:46 INFO - Return code: 0 12:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:46 INFO - https://queue.taskcluster.net/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:01:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 12:01:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 12:01:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/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 12:01:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/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 12:03:20 INFO - Downloaded 10840145 bytes. 12:03:20 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'] 12:03:20 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 12:03:20 INFO - Return code: 0 12:03: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')]} 12:03:20 INFO - https://queue.taskcluster.net/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 12:03:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.dmg 12:03:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.dmg 12:03:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 12:03:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VGzaNy_QS7mGc95tMnwJ7w/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 12:03:23 INFO - Downloaded 86200839 bytes. 12:03:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.dmg 12:03:23 INFO - mkdir: /builds/slave/test/properties 12:03:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:03:23 INFO - Writing to file /builds/slave/test/properties/build_url 12:03:23 INFO - Contents: 12:03:23 INFO - build_url:https://queue.taskcluster.net/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.dmg 12:03:24 INFO - Running post-action listener: _resource_record_post_action 12:03:24 INFO - Running post-action listener: set_extra_try_arguments 12:03:24 INFO - ##### 12:03:24 INFO - ##### Running populate-webroot step. 12:03:24 INFO - ##### 12:03:24 INFO - Running pre-action listener: _resource_record_pre_action 12:03:24 INFO - Running main action method: populate_webroot 12:03:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:03:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:03:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:03:24 INFO - '--tppagecycles', 12:03:24 INFO - '7'], 12:03:24 INFO - 'tests': ['tsvgm']}}, 12:03:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:03:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:03:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:03:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:03:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:03:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:03:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:24 INFO - 'talos_options': ['--disable-e10s'], 12:03:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:03:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:03:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:24 INFO - 'talos_options': ['--disable-e10s'], 12:03:24 INFO - 'tests': ['damp', 'tps']}, 12:03:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:24 INFO - 'tests': ['damp', 'tps']}, 12:03:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:03:24 INFO - 'tests': ['dromaeo_dom']}, 12:03:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:03:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:03:24 INFO - 'tests': ['a11yr', 12:03:24 INFO - 'ts_paint', 12:03:24 INFO - 'tpaint', 12:03:24 INFO - 'sessionrestore', 12:03:24 INFO - 'sessionrestore_no_auto_restore', 12:03:24 INFO - 'tabpaint']}, 12:03:24 INFO - 'other-e10s': {'tests': ['a11yr', 12:03:24 INFO - 'ts_paint', 12:03:24 INFO - 'tpaint', 12:03:24 INFO - 'sessionrestore', 12:03:24 INFO - 'sessionrestore_no_auto_restore', 12:03:24 INFO - 'tabpaint']}, 12:03:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:03:24 INFO - 'ts_paint', 12:03:24 INFO - 'tpaint', 12:03:24 INFO - 'sessionrestore', 12:03:24 INFO - 'sessionrestore_no_auto_restore', 12:03:24 INFO - 'tabpaint']}, 12:03:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:03:24 INFO - 'ts_paint', 12:03:24 INFO - 'tpaint', 12:03:24 INFO - 'sessionrestore', 12:03:24 INFO - 'sessionrestore_no_auto_restore', 12:03:24 INFO - 'tabpaint']}, 12:03:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:03:24 INFO - 'tests': ['a11yr', 12:03:24 INFO - 'ts_paint', 12:03:24 INFO - 'tpaint', 12:03:24 INFO - 'sessionrestore', 12:03:24 INFO - 'sessionrestore_no_auto_restore', 12:03:24 INFO - 'tabpaint']}, 12:03:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:03:24 INFO - 'tests': ['a11yr', 12:03:24 INFO - 'ts_paint', 12:03:24 INFO - 'tpaint', 12:03:24 INFO - 'sessionrestore', 12:03:24 INFO - 'sessionrestore_no_auto_restore', 12:03:24 INFO - 'tabpaint']}, 12:03:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:03:24 INFO - 'tests': ['tsvgx', 12:03:24 INFO - 'tsvgr_opacity', 12:03:24 INFO - 'tart', 12:03:24 INFO - 'tscrollx', 12:03:24 INFO - 'cart']}, 12:03:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:03:24 INFO - 'tsvgr_opacity', 12:03:24 INFO - 'tart', 12:03:24 INFO - 'tscrollx', 12:03:24 INFO - 'cart']}, 12:03:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:24 INFO - 'talos_options': ['--disable-e10s'], 12:03:24 INFO - 'tests': ['tp5o']}, 12:03:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:24 INFO - 'tests': ['tp5o']}, 12:03:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:24 INFO - 'talos_options': ['--disable-e10s', 12:03:24 INFO - '--xperf_path', 12:03:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:03:24 INFO - 'tests': ['tp5n']}, 12:03:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:24 INFO - 'talos_options': ['--xperf_path', 12:03:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:03:24 INFO - 'tests': ['tp5n']}}, 12:03:24 INFO - 'talos.zip': {'path': '', 12:03:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:03:24 INFO - Running post-action listener: _resource_record_post_action 12:03:24 INFO - ##### 12:03:24 INFO - ##### Running create-virtualenv step. 12:03:24 INFO - ##### 12:03:24 INFO - Running pre-action listener: _resource_record_pre_action 12:03:24 INFO - Running main action method: create_virtualenv 12:03:24 INFO - Creating virtualenv /builds/slave/test/build/venv 12:03:24 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 12:03:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:03:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:03:24 INFO - Using real prefix '/tools/python27' 12:03:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:03:25 INFO - Installing distribute.............................................................................................................................................................................................done. 12:03:28 INFO - Installing pip.................done. 12:03:28 INFO - Return code: 0 12:03:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:28 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 0x10791ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f3d67f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077bde00>, '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 0x107626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077b8b20>, '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.m8kvtV10Ln/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.eukJFkQtVK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 12:03:28 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 12:03:28 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 12:03:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m8kvtV10Ln/Render', 12:03:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:28 INFO - 'HOME': '/Users/cltbld', 12:03:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:28 INFO - 'LOGNAME': 'cltbld', 12:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:28 INFO - 'MOZ_NO_REMOTE': '1', 12:03:28 INFO - 'NO_EM_RESTART': '1', 12:03:28 INFO - 'PAGER': '/bin/cat', 12:03:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:28 INFO - 'PWD': '/builds/slave/test', 12:03:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:28 INFO - 'SHELL': '/bin/bash', 12:03:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eukJFkQtVK/Listeners', 12:03:28 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 12:03:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:28 INFO - 'USER': 'cltbld', 12:03:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:28 INFO - 'XPC_FLAGS': '0x0', 12:03:28 INFO - 'XPC_SERVICE_NAME': '0', 12:03:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:28 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 12:03:28 INFO - Cleaning up... 12:03:28 INFO - Return code: 0 12:03:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:28 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 0x10791ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f3d67f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077bde00>, '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 0x107626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077b8b20>, '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.m8kvtV10Ln/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.eukJFkQtVK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 12:03:28 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 12:03:28 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 12:03:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m8kvtV10Ln/Render', 12:03:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:28 INFO - 'HOME': '/Users/cltbld', 12:03:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:28 INFO - 'LOGNAME': 'cltbld', 12:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:28 INFO - 'MOZ_NO_REMOTE': '1', 12:03:28 INFO - 'NO_EM_RESTART': '1', 12:03:28 INFO - 'PAGER': '/bin/cat', 12:03:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:28 INFO - 'PWD': '/builds/slave/test', 12:03:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:28 INFO - 'SHELL': '/bin/bash', 12:03:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eukJFkQtVK/Listeners', 12:03:28 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 12:03:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:28 INFO - 'USER': 'cltbld', 12:03:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:28 INFO - 'XPC_FLAGS': '0x0', 12:03:28 INFO - 'XPC_SERVICE_NAME': '0', 12:03:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:29 INFO - Downloading/unpacking psutil>=0.7.1 12:03:29 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 12:03:29 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 12:03:29 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 12:03:29 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 12:03:29 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 12:03:29 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 12:03:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:03:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:03:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:03:32 INFO - Installing collected packages: psutil 12:03:32 INFO - Running setup.py install for psutil 12:03:32 INFO - building 'psutil._psutil_osx' extension 12:03:32 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 12:03:32 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 12:03:32 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 12:03:32 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 12:03:33 INFO - building 'psutil._psutil_posix' extension 12:03:33 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 12:03:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:03:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:03:33 INFO - ^ 12:03:33 INFO - 1 warning generated. 12:03:33 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 12:03:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:03:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:03:33 INFO - Successfully installed psutil 12:03:33 INFO - Cleaning up... 12:03:33 INFO - Return code: 0 12:03:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:33 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 0x10791ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f3d67f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077bde00>, '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 0x107626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077b8b20>, '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.m8kvtV10Ln/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.eukJFkQtVK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 12:03:33 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 12:03:33 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 12:03:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m8kvtV10Ln/Render', 12:03:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:33 INFO - 'HOME': '/Users/cltbld', 12:03:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:33 INFO - 'LOGNAME': 'cltbld', 12:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:33 INFO - 'MOZ_NO_REMOTE': '1', 12:03:33 INFO - 'NO_EM_RESTART': '1', 12:03:33 INFO - 'PAGER': '/bin/cat', 12:03:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:33 INFO - 'PWD': '/builds/slave/test', 12:03:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:33 INFO - 'SHELL': '/bin/bash', 12:03:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eukJFkQtVK/Listeners', 12:03:33 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 12:03:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:33 INFO - 'USER': 'cltbld', 12:03:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:33 INFO - 'XPC_FLAGS': '0x0', 12:03:33 INFO - 'XPC_SERVICE_NAME': '0', 12:03:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:03:33 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 12:03:33 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 12:03:33 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 12:03:33 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 12:03:33 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 12:03:33 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 12:03:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:03:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:03:36 INFO - Installing collected packages: mozsystemmonitor 12:03:36 INFO - Running setup.py install for mozsystemmonitor 12:03:36 INFO - Successfully installed mozsystemmonitor 12:03:36 INFO - Cleaning up... 12:03:36 INFO - Return code: 0 12:03:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:03:36 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')]} 12:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:36 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')]} 12:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:36 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 0x10791ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f3d67f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077bde00>, '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 0x107626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077b8b20>, '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.m8kvtV10Ln/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.eukJFkQtVK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 12:03:36 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 12:03:36 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 12:03:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m8kvtV10Ln/Render', 12:03:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:36 INFO - 'HOME': '/Users/cltbld', 12:03:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:36 INFO - 'LOGNAME': 'cltbld', 12:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:36 INFO - 'MOZ_NO_REMOTE': '1', 12:03:36 INFO - 'NO_EM_RESTART': '1', 12:03:36 INFO - 'PAGER': '/bin/cat', 12:03:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:36 INFO - 'PWD': '/builds/slave/test', 12:03:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:36 INFO - 'SHELL': '/bin/bash', 12:03:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eukJFkQtVK/Listeners', 12:03:36 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 12:03:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:36 INFO - 'USER': 'cltbld', 12:03:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:36 INFO - 'XPC_FLAGS': '0x0', 12:03:36 INFO - 'XPC_SERVICE_NAME': '0', 12:03:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:36 INFO - Downloading/unpacking blobuploader==1.2.4 12:03:36 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 12:03:36 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 12:03:36 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 12:03:36 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 12:03:36 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 12:03:36 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 12:03:39 INFO - Downloading blobuploader-1.2.4.tar.gz 12:03:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:03:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:03:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:40 INFO - Downloading docopt-0.6.1.tar.gz 12:03:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:03:40 INFO - Installing collected packages: blobuploader, requests, docopt 12:03:40 INFO - Running setup.py install for blobuploader 12:03:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:03:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:03:40 INFO - Running setup.py install for requests 12:03:40 INFO - Running setup.py install for docopt 12:03:41 INFO - Successfully installed blobuploader requests docopt 12:03:41 INFO - Cleaning up... 12:03:41 INFO - Return code: 0 12:03:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:41 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 0x10791ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f3d67f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077bde00>, '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 0x107626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077b8b20>, '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.m8kvtV10Ln/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.eukJFkQtVK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 12:03:41 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 12:03:41 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 12:03:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m8kvtV10Ln/Render', 12:03:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:41 INFO - 'HOME': '/Users/cltbld', 12:03:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:41 INFO - 'LOGNAME': 'cltbld', 12:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:41 INFO - 'MOZ_NO_REMOTE': '1', 12:03:41 INFO - 'NO_EM_RESTART': '1', 12:03:41 INFO - 'PAGER': '/bin/cat', 12:03:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:41 INFO - 'PWD': '/builds/slave/test', 12:03:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:41 INFO - 'SHELL': '/bin/bash', 12:03:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eukJFkQtVK/Listeners', 12:03:41 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 12:03:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:41 INFO - 'USER': 'cltbld', 12:03:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:41 INFO - 'XPC_FLAGS': '0x0', 12:03:41 INFO - 'XPC_SERVICE_NAME': '0', 12:03:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:03:41 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-1k9dK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:03:41 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-LbSTsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:03:41 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-qirGRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:03:41 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-5oZOss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:03:41 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-RKtkWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:03:41 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-wUX6mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:03:42 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-IGi5XT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:03:42 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-HXkYO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:03:42 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-K4amgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:03:42 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-J3O06U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:03:42 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Z68d21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:03:42 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-cgldXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:03:42 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-eIeY0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:03:42 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-a81Ke9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:42 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-BaBodp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:03:43 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-C7xqIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:03:43 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-i956Wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:03:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:03:43 INFO - Running setup.py install for manifestparser 12:03:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:03:43 INFO - Running setup.py install for mozcrash 12:03:43 INFO - Running setup.py install for mozdebug 12:03:43 INFO - Running setup.py install for mozdevice 12:03:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:03:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:03:43 INFO - Running setup.py install for mozfile 12:03:43 INFO - Running setup.py install for mozhttpd 12:03:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for mozinfo 12:03:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for mozInstall 12:03:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for mozleak 12:03:44 INFO - Running setup.py install for mozlog 12:03:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for moznetwork 12:03:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:03:44 INFO - Running setup.py install for mozprocess 12:03:44 INFO - Running setup.py install for mozprofile 12:03:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:03:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:03:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:03:45 INFO - Running setup.py install for mozrunner 12:03:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:03:45 INFO - Running setup.py install for mozscreenshot 12:03:45 INFO - Running setup.py install for moztest 12:03:45 INFO - Running setup.py install for mozversion 12:03:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:03:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:03:45 INFO - Cleaning up... 12:03:45 INFO - Return code: 0 12:03:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:03: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')]} 12:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03: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')]} 12:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:45 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 0x10791ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f3d67f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077bde00>, '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 0x107626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077b8b20>, '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.m8kvtV10Ln/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.eukJFkQtVK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 12:03:45 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 12:03:45 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 12:03:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m8kvtV10Ln/Render', 12:03:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:45 INFO - 'HOME': '/Users/cltbld', 12:03:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:45 INFO - 'LOGNAME': 'cltbld', 12:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:45 INFO - 'MOZ_NO_REMOTE': '1', 12:03:45 INFO - 'NO_EM_RESTART': '1', 12:03:45 INFO - 'PAGER': '/bin/cat', 12:03:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:45 INFO - 'PWD': '/builds/slave/test', 12:03:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:45 INFO - 'SHELL': '/bin/bash', 12:03:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eukJFkQtVK/Listeners', 12:03:45 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 12:03:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:45 INFO - 'USER': 'cltbld', 12:03:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:45 INFO - 'XPC_FLAGS': '0x0', 12:03:45 INFO - 'XPC_SERVICE_NAME': '0', 12:03:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:03:46 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-PBM6st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:03:46 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-g0y92s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:03:46 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-PzMjc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:03:46 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-bKHZzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:03:46 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-_uKjNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:03:46 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-l7pjEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:03:46 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Irv4yM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:03:46 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Jf9JiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:03:46 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-xvLV5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:03:46 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)) 12:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:03:46 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-XrOX8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:03:47 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)) 12:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:03:47 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-hDsmzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:03:47 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)) 12:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:03:47 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-pQ9ECV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:03:47 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)) 12:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:03:47 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-tGOVWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:03:47 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)) 12:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:03:47 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-FfpYrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:03:47 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)) 12:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:47 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-3doIl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:47 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)) 12:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:03:47 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-nfkB4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:03:47 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)) 12:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:03:47 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-eM4DKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:03:47 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)) 12:03:47 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)) 12:03:47 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)) 12:03:47 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)) 12:03:47 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)) 12:03:47 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)) 12:03:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:50 INFO - Downloading blessings-1.6.tar.gz 12:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:03:50 INFO - Installing collected packages: blessings 12:03:50 INFO - Running setup.py install for blessings 12:03:50 INFO - Successfully installed blessings 12:03:50 INFO - Cleaning up... 12:03:50 INFO - Return code: 0 12:03:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:03:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:03:50 INFO - Reading from file tmpfile_stdout 12:03:50 INFO - Current package versions: 12:03:50 INFO - blessings == 1.6 12:03:50 INFO - blobuploader == 1.2.4 12:03:50 INFO - docopt == 0.6.1 12:03:50 INFO - manifestparser == 1.1 12:03:50 INFO - mozInstall == 1.12 12:03:50 INFO - mozcrash == 0.17 12:03:50 INFO - mozdebug == 0.1 12:03:50 INFO - mozdevice == 0.48 12:03:50 INFO - mozfile == 1.2 12:03:50 INFO - mozhttpd == 0.7 12:03:50 INFO - mozinfo == 0.9 12:03:50 INFO - mozleak == 0.1 12:03:50 INFO - mozlog == 3.1 12:03:50 INFO - moznetwork == 0.27 12:03:50 INFO - mozprocess == 0.22 12:03:50 INFO - mozprofile == 0.28 12:03:50 INFO - mozrunner == 6.11 12:03:50 INFO - mozscreenshot == 0.1 12:03:50 INFO - mozsystemmonitor == 0.0 12:03:50 INFO - moztest == 0.7 12:03:50 INFO - mozversion == 1.4 12:03:50 INFO - psutil == 3.1.1 12:03:50 INFO - requests == 1.2.3 12:03:50 INFO - wsgiref == 0.1.2 12:03:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:03: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')]} 12:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03: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')]} 12:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:50 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 0x10791ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f3d67f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077bde00>, '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 0x107626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077b8b20>, '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.m8kvtV10Ln/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.eukJFkQtVK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 12:03:50 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 12:03:50 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 12:03:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m8kvtV10Ln/Render', 12:03:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:50 INFO - 'HOME': '/Users/cltbld', 12:03:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:50 INFO - 'LOGNAME': 'cltbld', 12:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:50 INFO - 'MOZ_NO_REMOTE': '1', 12:03:50 INFO - 'NO_EM_RESTART': '1', 12:03:50 INFO - 'PAGER': '/bin/cat', 12:03:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:50 INFO - 'PWD': '/builds/slave/test', 12:03:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:50 INFO - 'SHELL': '/bin/bash', 12:03:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eukJFkQtVK/Listeners', 12:03:50 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 12:03:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:50 INFO - 'USER': 'cltbld', 12:03:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:50 INFO - 'XPC_FLAGS': '0x0', 12:03:50 INFO - 'XPC_SERVICE_NAME': '0', 12:03:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:51 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)) 12:03:51 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)) 12:03:51 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)) 12:03:51 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)) 12:03:51 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)) 12:03:51 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)) 12:03:51 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)) 12:03:51 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)) 12:03:51 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)) 12:03:51 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)) 12:03:51 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)) 12:03:51 INFO - Cleaning up... 12:03:51 INFO - Return code: 0 12:03:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10791ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f3d67f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077bde00>, '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 0x107626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077b8b20>, '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.m8kvtV10Ln/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.eukJFkQtVK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 12:03:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:03:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m8kvtV10Ln/Render', 12:03:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:51 INFO - 'HOME': '/Users/cltbld', 12:03:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:51 INFO - 'LOGNAME': 'cltbld', 12:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:51 INFO - 'MOZ_NO_REMOTE': '1', 12:03:51 INFO - 'NO_EM_RESTART': '1', 12:03:51 INFO - 'PAGER': '/bin/cat', 12:03:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:51 INFO - 'PWD': '/builds/slave/test', 12:03:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:51 INFO - 'SHELL': '/bin/bash', 12:03:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eukJFkQtVK/Listeners', 12:03:51 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 12:03:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:51 INFO - 'USER': 'cltbld', 12:03:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:51 INFO - 'XPC_FLAGS': '0x0', 12:03:51 INFO - 'XPC_SERVICE_NAME': '0', 12:03:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:51 INFO - Downloading/unpacking jsonschema 12:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:03:53 INFO - Downloading/unpacking functools32 (from jsonschema) 12:03: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 12:03: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 12:03: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 12:03: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 12:03: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 12:03: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 12:03:54 INFO - Downloading functools32-3.2.3-2.tar.gz 12:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:03:54 INFO - warning: no files found matching '*.txt' 12:03:54 INFO - no previously-included directories found matching 'build' 12:03:54 INFO - no previously-included directories found matching 'dist' 12:03:54 INFO - no previously-included directories found matching '.git*' 12:03:54 INFO - Installing collected packages: jsonschema, functools32 12:03:54 INFO - Running setup.py install for functools32 12:03:54 INFO - warning: no files found matching '*.txt' 12:03:54 INFO - no previously-included directories found matching 'build' 12:03:54 INFO - no previously-included directories found matching 'dist' 12:03:54 INFO - no previously-included directories found matching '.git*' 12:03:54 INFO - Successfully installed jsonschema functools32 12:03:54 INFO - Cleaning up... 12:03:54 INFO - Return code: 0 12:03:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:54 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 0x10791ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f3d67f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077bde00>, '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 0x107626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077b8b20>, '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.m8kvtV10Ln/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.eukJFkQtVK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 12:03:54 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 12:03:54 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 12:03:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m8kvtV10Ln/Render', 12:03:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:54 INFO - 'HOME': '/Users/cltbld', 12:03:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:54 INFO - 'LOGNAME': 'cltbld', 12:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:54 INFO - 'MOZ_NO_REMOTE': '1', 12:03:54 INFO - 'NO_EM_RESTART': '1', 12:03:54 INFO - 'PAGER': '/bin/cat', 12:03:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:54 INFO - 'PWD': '/builds/slave/test', 12:03:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:54 INFO - 'SHELL': '/bin/bash', 12:03:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eukJFkQtVK/Listeners', 12:03:54 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 12:03:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:54 INFO - 'USER': 'cltbld', 12:03:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:54 INFO - 'XPC_FLAGS': '0x0', 12:03:54 INFO - 'XPC_SERVICE_NAME': '0', 12:03:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:54 INFO - Downloading/unpacking flake8 12:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:03:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:03:57 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 12:03:57 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 12:03:57 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 12:03:57 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 12:03:57 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 12:03:57 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 12:03:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:03:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:03:57 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 12:03:57 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 12:03:57 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 12:03:57 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 12:03:57 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 12:03:57 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 12:03:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:03:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:03:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:03:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:03:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:03:58 INFO - no previously-included directories found matching 'docs/_build' 12:03:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:03:58 INFO - Running setup.py install for pep8 12:03:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:03:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:03:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:03:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:03:58 INFO - no previously-included directories found matching 'docs/_build' 12:03:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:03:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:03:58 INFO - Cleaning up... 12:03:58 INFO - Return code: 0 12:03:58 INFO - Running post-action listener: _resource_record_post_action 12:03:58 INFO - Running post-action listener: _start_resource_monitoring 12:03:58 INFO - Starting resource monitoring. 12:03:58 INFO - ##### 12:03:58 INFO - ##### Running install step. 12:03:58 INFO - ##### 12:03:58 INFO - Running pre-action listener: _resource_record_pre_action 12:03:58 INFO - Running main action method: install 12:03:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:03:59 INFO - Reading from file tmpfile_stdout 12:03:59 INFO - Detecting whether we're running mozinstall >=1.0... 12:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:03:59 INFO - Reading from file tmpfile_stdout 12:03:59 INFO - Output received: 12:03:59 INFO - Usage: mozinstall [options] installer 12:03:59 INFO - Options: 12:03:59 INFO - -h, --help show this help message and exit 12:03:59 INFO - -d DEST, --destination=DEST 12:03:59 INFO - Directory to install application into. [default: 12:03:59 INFO - "/builds/slave/test"] 12:03:59 INFO - --app=APP Application being installed. [default: firefox] 12:03:59 INFO - mkdir: /builds/slave/test/build/application 12:03:59 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'] 12:03:59 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 12:04:22 INFO - Reading from file tmpfile_stdout 12:04:22 INFO - Output received: 12:04:22 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:04:22 INFO - Running post-action listener: _resource_record_post_action 12:04:22 INFO - ##### 12:04:22 INFO - ##### Running run-tests step. 12:04:22 INFO - ##### 12:04:22 INFO - Running pre-action listener: _resource_record_pre_action 12:04:22 INFO - Running main action method: run_tests 12:04:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:04:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:04:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:04:22 INFO - 2016-06-28 12:04:22.040 screenresolution[1653:8936] starting screenresolution argv=screenresolution get 12:04:22 INFO - 2016-06-28 12:04:22.043 screenresolution[1653:8936] Display 0: 1600x1200x32@60 12:04:22 INFO - 2016-06-28 12:04:22.049 screenresolution[1654:8938] starting screenresolution argv=screenresolution list 12:04:22 INFO - Available Modes on Display 0 12:04:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:04:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:04:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:04:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:04:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:04:22 INFO - Intel Iris: 12:04:22 INFO - Chipset Model: Intel Iris 12:04:22 INFO - Type: GPU 12:04:22 INFO - Bus: Built-In 12:04:22 INFO - VRAM (Dynamic, Max): 1536 MB 12:04:22 INFO - Vendor: Intel (0x8086) 12:04:22 INFO - Device ID: 0x0a2e 12:04:22 INFO - Revision ID: 0x0009 12:04:22 INFO - Displays: 12:04:22 INFO - Display: 12:04:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:04:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:04:22 INFO - Display Serial Number: 1600x1200 60 12:04:22 INFO - Main Display: Yes 12:04:22 INFO - Mirror: Off 12:04:22 INFO - Online: Yes 12:04:22 INFO - Rotation: Supported 12:04:22 INFO - Return code: 0 12:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:04:22 INFO - Python 2.7.3 12:04:22 INFO - Return code: 0 12:04:22 INFO - grabbing minidump binary from tooltool 12:04:22 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')]} 12:04:22 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 0x1077bde00>, '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 0x107626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077b8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:04:22 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 12:04:22 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 12:04:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:04:22 INFO - Return code: 0 12:04:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:04:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:04:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:04:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:04:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:04:23 INFO - Return code: 0 12:04:23 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-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:04:23 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-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0126 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:04:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m8kvtV10Ln/Render', 12:04:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:04:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:04:23 INFO - 'HOME': '/Users/cltbld', 12:04:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:04:23 INFO - 'LOGNAME': 'cltbld', 12:04:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:04:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:04:23 INFO - 'MOZ_NO_REMOTE': '1', 12:04:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:04:23 INFO - 'NO_EM_RESTART': '1', 12:04:23 INFO - 'PAGER': '/bin/cat', 12:04:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:04:23 INFO - 'PWD': '/builds/slave/test', 12:04:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:04:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:04:23 INFO - 'SHELL': '/bin/bash', 12:04:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eukJFkQtVK/Listeners', 12:04:23 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 12:04:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:04:23 INFO - 'USER': 'cltbld', 12:04:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:04:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:04:23 INFO - 'XPC_FLAGS': '0x0', 12:04:23 INFO - 'XPC_SERVICE_NAME': '0', 12:04:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:04:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:04:23 INFO - mozversion application_buildid: 20160628105123 12:04:23 INFO - mozversion application_changeset: cf85e0aa283eaaa522ddbc2749945ea97f249933 12:04:23 INFO - mozversion application_display_name: Firefox 12:04:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:04:23 INFO - mozversion application_name: Firefox 12:04:23 INFO - mozversion application_remotingname: firefox 12:04:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:04:23 INFO - mozversion application_vendor: Mozilla 12:04:23 INFO - mozversion application_version: 48.0 12:04:23 INFO - mozversion platform_buildid: 20160628105123 12:04:23 INFO - mozversion platform_changeset: cf85e0aa283eaaa522ddbc2749945ea97f249933 12:04:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:04:23 INFO - mozversion platform_version: 48.0 12:04:23 INFO - using testdate: 1467140663 12:04:23 INFO - actual date: 1467140663 12:04:23 INFO - starting webserver on 'localhost:49275' 12:04:23 INFO - SUITE-START | Running 2 tests 12:04:23 INFO - TEST-START | dromaeo_css 12:04:23 INFO - operating with platform_type : mac_ 12:04:23 INFO - Initialising browser for dromaeo_css test... 12:04:23 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpFwhgW1/profile http://localhost:49275/getInfo.html) 12:04:26 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 12:04:26 INFO - PROCESS | 1672 | colorDepth:24 12:04:26 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 12:04:26 INFO - PROCESS | 1672 | __metrics 12:04:26 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 12:04:27 INFO - TEST-INFO | 1672: exit 0 12:04:27 INFO - Browser initialized. 12:04:27 INFO - Running cycle 1/1 for dromaeo_css test... 12:04:27 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpFwhgW1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:04:39 INFO - PROCESS | 1677 | RSS: Main: 171081728 12:04:39 INFO - PROCESS | 1677 | 12:05:28 INFO - PROCESS | 1677 | 1467140728816 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] 12:07:38 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 12:07:40 INFO - PROCESS | 1677 | RSS: Main: 182124544 12:07:40 INFO - PROCESS | 1677 | 12:10:42 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 12:10:42 INFO - PROCESS | 1677 | RSS: Main: 192749568 12:10:42 INFO - PROCESS | 1677 | 12:13:44 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 12:13:45 INFO - PROCESS | 1677 | RSS: Main: 194695168 12:13:45 INFO - PROCESS | 1677 | 12:16:46 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 12:16:47 INFO - PROCESS | 1677 | RSS: Main: 198565888 12:16:47 INFO - PROCESS | 1677 | 12:19:49 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 12:19:50 INFO - PROCESS | 1677 | RSS: Main: 197615616 12:19:50 INFO - PROCESS | 1677 | 12:22:52 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 12:22:52 INFO - PROCESS | 1677 | RSS: Main: 202366976 12:22:52 INFO - PROCESS | 1677 | 12:22:52 INFO - PROCESS | 1677 | __start_tp_report 12:22:52 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 12:22:52 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 12:22:52 INFO - PROCESS | 1677 | |i|pagename|runs| 12:22:52 INFO - PROCESS | 1677 | |0;dojo.html;2800.285927088593;3662.9084272893174;3690.926181476372;3695.9630403695965;3710.183759572895;5927.199828023216;5929.673867937262;5977.7011149442515;5979.880402391944;5982.312034116078;4956.603471722263;5990.670513121777;6006.939930600693;6007.219061522007;6009.399060093989;5292.788288468466;5365.275687782158;5406.270153529283;5456.372517160537;5515.696636684981;5337.839864804062;5400.891982160354;5401.162819762943;5449.809256676017;5518.751656175462;5454.699991500466;5486.451354864502;5494.752736126884;5511.118221084627;5519.806806761764;5337.813176538842;5456.590755693339;5467.9453205467835;5470.343558772933;5474.671519708831;5266.473352664703;5281.551068159211;5302.787888484456;5335.546478549328;5383.2194331821665;5582.246396736429;5649.322081350223;5677.40387259336;5685.1756495307945;5775.104858746859;6219.315875253718;6252.18721566198;6269.905951410732;6283.622982621057;6314.431701146873;6045.818625441244;6249.0626406039;6281.089242059876;6290.654014029226;6330.8100756977365;6020.307664618537;6035.245594300713;6057.151998720183;6064.272287325549;6075.149479072933;6282.151909492251;6382.680865956683;6408.775692850728;6410.487161027107;6432.228132624022;6203.379662033761;6272.498200143978;6279.905801412982;6281.96859015702;6309.589876658094;6256.6871656417;6276.623402595859;6310.873782524323;6312.684365781693;6324.367563243731;6022.3676513966275;6203.689815509297;6244.625322480666;6262.9666105093065;6267.9971204607955;5265.76304066318;6242.843928901723;6258.718357673915;6286.937130628727;6296.5592408531875;4995.650304478651;5010.872553675394;5053.873653158627;5056.84829455117;5061.848144555669;4485.529019452975;4518.2319005769095;4573.314002899591;4636.582707556337;4639.443266807937;4737.194676904865;5817.418258174233;5868.325142608569;5879.823605291848;5999.0401535754945;6237.906431403532;6303.023031430135;6307.148534947815;6320.62076275425;6326.810195694136;5943.465088142001;6025.367336429612;6088.756449742049;6106.694665266719;6116.847078823065;5538.833834984957;5545.611807173459;5547.084731019418;5549.250851135126;5568.777248910079;6488.221413430419;6500.187476565429;6502.252240992252;6524.445422139076;6534.640594767334;6184.876302474016;6237.500999919905;6290.748370065329;6292.182016337847;6345.714442850175;6474.805755827333;6498.317676643885;6506.089147519446;6507.902381464377;6535.967320163369;6219.315875253628;6285;6286.654234017173;6288.245410550763;6330.461910737639;6221.906671399842;6262.53031022666;6284.340144284784;6340.714667839866;6342.682865856781;6177.725342612316;6261.436470717657;6263.96868015657;6271.749130034747;6304.243490780952;6137.315698287052;6262.405071518198;6285.874282514415;6289;6312.589681670676;5889.5582831286965;6088.299845517822;6114.6636934969;6125.84685382869;6163.876722465615;6203.131561581292;6222.16000839899;6226.844328891814;6234.875302494015;6264.906026409516;6088.117223002551;6118.632882027093;6193.256809182927;6199.907001394892;6255.343188965275 12:22:52 INFO - PROCESS | 1677 | |1;ext.html;542.2002546244288;567.9862306368332;571.6312978129107;572.4218539275331;589.6579983609505;34202;39626.216820243084;40814.38778418326;41534.792326038325;41559;32477.350452990926;42960.570394296046;43815;43821.12357752843;43993.560064399346;9711;9911.405315681046;9920.057594528509;9928.305018648698;9936.801263974716;9719.854202186973;9884.950575247114;9952.502374881227;10009.749756256078;10032.247581431386;9854.211663066973;9886.901130988706;9915.801683966316;10003.249756268273;10030.890423968593;9837.311388202828;9862.260330475172;9878.308518403715;9986.300958932878;9998.700038998806;9775.462349570771;9795.902040979641;9895.059969302905;9900.257480688904;9929.503524823802;34403.13992150191;41315.793421033006;41414.37878431826;41965.58034419678;43596.346054809204;3102.689731026902;3222.7582931280012;3330.7501937354555;3471.3057388522143;3839.9616003840165;27074.458510829674;27547.898084076613;27686.169414917586;27764.444711105865;28147.577786333222;2633.604959256127;2696.150712525548;2716.578930265812;2734.671839379287;2774.1261502626608;330741;336193;336470.99999999756;336836;338493;37594;37804.243915121544;37804.2439151221;37942.62057379391;38641.806790965864;35554.11114722101;35619.93140205798;35626;36337.27325453476;36510.63489365125;16364;16615.750763738553;16849.32602695903;16870.915645421694;16879.91560042192;13832.654183645489;13851.584452466443;13973.301334933212;14203.502877399447;14257.92871035659;8704;8777.517236551923;8784.42901211432;8827;8843.646254149891;3264.183954011497;3523.612402635708;3585.4084076127147;3637.563492380931;3650.3429382710838;1032.4682788363998;1054.6079175488435;1142.8228624563205;1207.704112492445;1235.8640549539543;30241;31252;31608.683913161032;31940.04179874561;32152.678473215437;1185.057878986208;1187.7268228307364;1192.4991503568522;1226.7055906582534;1245.735578387937;13566.644207522422;15881.28534215963;16130.677386452206;16183.271752771154;16360.754588681179;658897;660647;665132;668446;671552;66140.66929665321;66375.66812166006;66562.66718666472;66783;66876;1363.3387806913638;1561.1578337561787;1582.5727053695439;1586.9682606347808;1680.3026743901144;30192.84903575468;30899.227519312197;30955.761769528966;31233.531497027107;31453.213669657525;57712.4228757707;57874.13188802087;57951.71024144852;58039.4196058034;58124;593790;597293;597833;598148;598877.0056149692;27943.441131177668;28427.431451370445;28533.571996420487;28600.856995714887;28773.568396473653;48968.51031489782;49415.50584494109;49853.75073124611;50459.243111352625;50528.74735626298;36404.725834595665;36832.07919802026;39361;39513;39833.40249896196;38669.41995870008;38767.224655506165;39587.80206099066;40048.3992740115;40570.79714601408;34128.14679633029;39355.409668855566;39398.80300598593;40093;40572.78281651555;32873;34117.65882341244;34323.4851477233;34676.65323346734;34929;21145.304093508534;21569.78430215678;25795.097171598904;26076.73923260743;26686.932522698873 12:22:52 INFO - PROCESS | 1677 | |2;jquery.html;363.5709862362413;376.5011359948069;411.38087178795905;415.37900838246827;419.2872117400419;15694.607634809136;20898.955052247384;21375.251866184666;21543.461413464673;21749.238776642822;21573.568528629417;21862.672059919114;22303;22408.88795556024;23030.424239394022;5991.86154630621;5996.460318571328;6302.653354065525;6316.178896743417;6333.366663333676;6117.327094019654;6156.1996940397685;6238.376162383748;6254.374562543755;6264.029075493283;5356.598255130862;5995.880082398349;6191.102290167923;6233.407826256498;6296.559240853142;5180.352455943007;5228.633995620308;6106.755729770848;6162.322144564095;6220.507078301198;5201.895962080737;5477.780888764445;5509.889802203974;5548.9722551386985;5566.443355664442;27721.86139069312;27884;27927;27930.860345698344;28416.28959276014;2244.394013616331;2275;2286.8513546619415;2295.678604995302;2742.945141097187;15001.099934003885;15713.292901819332;15849.92075039629;15920.76118858218;16367.85425020249;1854.1470923375264;1867.2997625890291;1882.9246830126915;1887.5375532994503;1904.1145867171692;78794.60602697007;81394.77907831446;82361.58819205925;112356.4382178092;112655;9424.29317801154;11884;12261.26432414058;12289.078319125923;12512.81230781539;15632.905696601356;15672.843271567366;15958.680826383408;15992.520224393287;16035.919820401057;8018.5990700464745;9020.097990201059;9503.429794212369;9542.902566204975;9620.422774633544;7875.133735289113;9224.631014759469;9389;9591.232701384011;9603.807923841485;4903.915835769783;4946.777395017233;4964.726940018261;5003.774830132653;5024.84925452237;2055.0715230796054;2099.7847271129103;2120.8971334905764;2139.6677621392755;2172;947.9336446448682;1055.625253035177;1066.5520481397832;1067.631667074858;1077.1221454514546;16366.018038917702;17142.485725428258;20400.387988360373;21021.78978210229;21837.890810545847;1000.0449121966537;1011.8532812742111;1033.7725700345911;1039.8856125826153;1042.4527123260198;11304.378259195822;11550.96041356282;11569.132315076404;11583.536658533565;11619.535218591162;544407;632450;642380;650770;680725;136017.3199133998;141186;141415;142331;148142.29644258766;1070.0369667299337;1085.5169449595012;1101.9393933333583;1142.702897246722;1143.3711458697683;15534.300956457213;19603;19926;20246.392608221777;20675.68986465174;43511.56488435202;56558.58603534944;57358.42641573531;57767;57987.13019304798;81393.59303203446;83047.16952830394;83642;84511.15488845033;85406;8586.313094952264;8607.096254893146;8703.43427677199;8754.649814007369;8805.119488051143;9475.526223688927;12825.615231542695;13143.342832858127;13393.732125357243;13400.396982136022;11289.774204516028;11393.08855291558;11552.59565915189;11740.765184696429;11763.705907352043;11198.832017519906;11366;11513.654590362303;11687.941560292144;11897.048236141261;9537.47543885093;11465.770684586094;11548.018418434527;11661.35862527569;11907.642770716893;8446.957765211135;8642.654293828176;8691.174338437839;8712;8809.339299552432;8733.781655458664;9233.49215793111;10981;11080.67031956138;11238.943805280922 12:22:52 INFO - PROCESS | 1677 | |3;mootools.html;1614.112238268952;1622.6267958369572;1930.758655168104;2027.4019164346525;2044.7341845560074;8340.040895297043;8920.73237802867;9058.501782401965;9236;9275.76810579735;9075.591598378072;9121.133492318218;9188.219001384874;9207;9211.90788092119;2503.7621425964503;2504.686914135733;2509.121807367425;2527.140772137473;2537.13737329308;2465.5561998840203;2540.0220914947786;2541.0852093246417;2541.5298169838547;2542.4915016996583;2526.68416447944;2533.809964252679;2574.948501029978;2578.40696639773;2585.418280886804;2206.6910632511463;2501.94918134384;2526.418923647553;2553.3871870750977;2562.052040744927;2527.6082207257905;2548.5922252439523;2551.9106831260815;2554.029468801862;2561.5645340292194;9133.36066475347;9232.584533696;9262.027487113823;9272.397294175857;9281.53592320388;5631.943680563224;5643.915341269884;5655.943440565583;5675.063614503602;5805.36141024487;3445.620981692012;3555.1645363339853;3641.563012438498;3714.4428335749585;3768.3405404054456;1064.2071656615794;1069.219469787052;1074.044100750325;1082.5994382078602;1085.066842515436;12270.570530031406;12550.623481295575;12580.559680411234;12598.874011259953;12609.495620175181;4905.975470122627;4964;5058.974705126451;5083.949160508421;5090.974545127251;10597.523111460003;10598.947005264925;10606.522706478227;10614.628488002883;10618.991195836383;5612.859678507988;5625.859353516113;5634;5679.488846003879;5682.176084467729;4681.531846815291;5099.745012749348;5180.404253510819;5188.9740551297;5244.973775131176;4180.644645205191;4205;4242.915141697149;4274.529801721808;4282.443282373271;1370.6293706293707;1390.5897760160776;1400.271858633505;1402.1236727045596;1404.4803422733653;924.5977999570208;939.2392162348519;959.3092973059386;975.5902520941222;990.3414229537277;6120;6131.356207598227;6257.530685198628;6272.466840318532;6282.717277722513;463.54109431662414;466.8786115609966;473.47917290980337;1049.4437947887632;1051.5636011055326;3635.8728794073922;3936.5079365079364;3999;4060.7766572838777;4091.2022155679356;10874.945625271823;10998.945005274922;11326.943365283121;11348.943255283672;11395.746467888526;10924.890751092546;10947.56209751601;10976.725581860357;11027.44862756859;11072.280301780358;6934.757283495053;8614.612342444605;8626.525541095174;8737.912620873836;8804.075572065098;5929.288485381781;5951.434613711864;6012.398760123952;6021.54838387114;6051.364606716232;9989.60041598328;10083.546240419051;10099.69700908974;10202;10324.48377581133;10080.69757907264;10483.423411712429;10575;10636.680899573024;10725.731856703645;6663.666816659051;7098.3256590623805;7321.78034658961;7353;7460.925390746023;8598.097199794182;8627.396082274181;8645.783855403664;8647.308215342884;8671.696490622799;7501.662425190771;7658.961705191438;7666;7697.230276972258;7831.334336581226;7494.288042635941;7509.549427034395;7518.774436766906;7556.546607203585;7653.540787552764;7357.043584334217;7371.668274927534;7386.519876208029;7391.1869694334655;7403.5928023959195;4387.802548885244;5003.849884503471;5008.724520151281;5043.470435604208;5170.43125256214;4486.50648428666;4590.472095709036;5245.265662807286;5254.947450525446;5336.412994570516 12:22:52 INFO - PROCESS | 1677 | |4;prototype.html;270.7171006298418;329.20825414877214;336.21493811949097;339.65864306372094;341.68223552096555;6939.653017349125;6957.547759395648;6958.408535274495;6967.198772141205;6988.685509152087;6848.246692863793;6854.82862928427;6865.485088618361;6912.930870691304;6976.337247961435;4848.563629273356;4902.558769710726;5036.017976494585;5053.84838454847;5054.241863720453;4993.176125939216;5042.773075211624;5044.319016932704;5051.747412629354;5063.594912407017;4966.230234313687;4988.925166122511;4991.450940396553;5015.824446144386;5025.994801039788;5003.14946459101;5020.2218656108;5026.673266237683;5042.949570504321;5048.7728052237735;4326.178026175016;4343.2399330117105;4343.826246950118;4349.80425880833;4352.737706065237;4943.431505376891;6583.407493325576;6602.570832895846;6622.139121914169;6642.169728783902;5853.473187413153;5890.852728681774;5897.233359663259;5899.262592175978;5934.228550288478;7374.041374621265;7375.520591161611;7391.704331826721;7406.814829629248;7409.222031686649;4695.483496815347;4700.788464519105;4701.553352431513;4709.011107667394;4712.764361781931;7520.398368130536;7696.884546731803;7768.844623107506;7780.922190778077;7840.607969601497;4490.528494508095;4778.665493415428;4809.615230781529;4825.445073816556;4828.517148285214;4894.510548945077;4900.921797204609;4904.975475122602;4918.9508104919205;4931.778069986859;5925.022371308686;5938.138969849434;5946.762129514771;5955.7617695292565;5972.880542389128;6654.966725166343;6869.900815869437;7458.29146231118;7471.738489152854;7487.401007919353;1635.4602981016237;1678.2867281405597;1699.4646686293777;1701.7447382892665;1707.6670049340507;1058.6347710040025;1064.9520771565299;1071.603506702525;1076.0476977874637;1077.1867240233573;6545.214574251025;6724.798256052326;6870.690818913161;6910.101686780687;6975.372216500539;7488.251174882577;7632.732854350183;7695.115061767969;7696.190385759085;7706.922930770733;6962.1297337832775;6991.161060672752;7050.435965122778;7052.118485189351;7066.116735408074;3528.6647768461953;3963.722539422213;4095;4131.975332087256;4146.543880173179;8143.714969976022;8173.754787356389;8187.304079153219;8190.672373105009;8196;7850.582788915259;7965.522068675898;8100.797480063045;8110.959445202736;8116.959415202886;8136.471129376571;8154.306883914934;8167.264946154874;8173.550454724928;8173.610486217239;7811.570363630055;7849.411294153076;7852.646630901509;7858.764237072897;7869.252421019994;5898.587098903207;7141.535800172972;7640.541567505968;7643.541387516767;7684.193159718149;6932.376086152271;7529.87051942213;8227.177282271725;8234.917650823416;8246.257836794717;4793.089313030513;4852.393450818648;4860.149473841992;4882.389701287339;4897.118518666674;7765.572893490912;7784.5718485481575;7784.649690763816;7800.921990780246;7820.569868657051;5714.714264286852;7509.849803004018;7518.473706840468;7526.962365188139;7562.697492100475;7494.850102997801;7499.2500749924575;7502;7523.360514356341;7545.547267163988;7422.554646721214;7493.063367079115;7498.962505187439;7522.849543009219;7536.171021187774;7492.063492063492;7503.399728021636;7538.359239464707;7559.244075592397;7559.5464272143845;7106.964465177641;7303.269673032654;7326.706931722884;7356.227596102332;7357.668904899186 12:22:52 INFO - PROCESS | 1677 | |5;yui.html;731.1409094314181;747.6897087708601;750.2160242546538;758.908930928288;772.3898120484814;15452.45916392925;15708.21458927052;15770.76343854843;15818.76271855923;15836.92081539592;14463.204523751216;14504.347304371302;14508.347124379401;14530.782038269408;14551.92724036381;761.6953218712532;901.9819603607924;915.1260546178416;915.9404638698496;915.9725208243764;903.905089965554;919.1957037592107;919.3426699909563;921.1479381572019;942.9905700942971;823.9629216685233;956.8038552096838;981.950902454878;985.8126955878396;1010.9898901011006;978.7846673731767;987.274353350287;987.8567607696915;988.9258305627106;999.9900100898109;752.289086812962;756.1908757629338;757.5984728094064;758.6396461680713;761.6077719974218;15244.847551524565;15280.694386112216;15526;15720.764188537181;15796;13349.998750093684;13486.19082855022;13491.527796527074;13585.796213056812;13608.183508989394;10049.995000499965;10329.225308101923;10335.328203666737;10422.374657520497;10664.466776661136;3556.822158892045;3613.3857244268274;3619.3666108431185;3678.44823276508;3680.190358121209;82801.58599207025;82838.75741863938;83772;84112.57943710242;84123;9724.562394692255;9774;9788.657396991071;9872.654457093968;10449.425281609432;22881;23776;23813.523729525314;23833.880830595735;23851.284461466184;7167.4266058715175;7394.963025184948;7455.366293864974;7763.2236776321915;7844.333231675258;3524.6122926478065;4098.549159592442;4135.813888375031;4147.460830092069;4329.415528903621;3366.4277072897667;3753;3756.417755247941;3833.1758671885677;3865.40086286626;652.8922727749868;670.2861452553016;671.5332843673698;680.2381332907175;680.6188534420642;527.6965744696814;567.1804242869015;589;615.1129277887144;618.8576627375729;6584.539082264196;7883.408744344082;8182.936218291703;8282.337413006944;8522.69897090022;487.4199702354187;528.5982653183609;555.6777069299796;620.7796232337546;624.3101372982879;3845.7115716321387;3965.8810235692977;3981.7810020449156;4067.186562687474;4211.578842115764;99575.50212248892;99577;99716;100160;101057;63786;83826;83899;84388.57805710932;87181;72972.63513682503;73451.63274183594;74102.88845667211;74933.62533187299;76393.61803190949;7966;8140.674373025013;8179.631916563888;8191.385646076687;8248.092709802037;51678.48321516737;52050.73974630254;52133.17533886296;52207.73896130495;55136.72431637816;56040;70854.29145708476;72209.63895180491;73883.89174162285;74929.25070749223;10145.28982971185;10198.235132365251;10213.693589192337;10235.385876847413;10409.47952602382;11377.488013039267;11383.146264030065;11464.484098215768;11515.769684606428;11563.248388854698;10040.196784257096;10192.3374980629;10197.388156710622;10344.896551034695;10685.839712404164;10602.310849794738;10780;10781.784364312512;10982.725431864268;11025.283356581796;9734.513274336396;9992.500374981368;10214.540345684314;10327.122194613241;10671.786564268516;7765.72819951299;9129.954350228472;9243.722688319362;9312.860307095263;9698.806023879624;9238.214751746176;9409.388389754919;9416.764580885532;9417.293702972167;9445.952770236105 12:22:52 INFO - PROCESS | 1677 | __end_tp_report 12:22:52 INFO - PROCESS | 1677 | __start_cc_report 12:22:52 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,396 12:22:52 INFO - PROCESS | 1677 | __end_cc_report 12:22:52 INFO - PROCESS | 1677 | __startTimestamp1467141772804__endTimestamp 12:22:52 INFO - PROCESS | 1677 | 12:22:52 INFO - PROCESS | 1677 | ------- Summary: start ------- 12:22:52 INFO - PROCESS | 1677 | Number of tests: 6 12:22:52 INFO - PROCESS | 1677 | 12:22:52 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5873.17 Median:6118.63 stddev:632.79 (10.3%) stddev-sans-first:587.02 12:22:52 INFO - PROCESS | 1677 | Values: 2800.3 3662.9 3690.9 3696.0 3710.2 5927.2 5929.7 5977.7 5979.9 5982.3 4956.6 5990.7 6006.9 6007.2 6009.4 5292.8 5365.3 5406.3 5456.4 5515.7 5337.8 5400.9 5401.2 5449.8 5518.8 5454.7 5486.5 5494.8 5511.1 5519.8 5337.8 5456.6 5467.9 5470.3 5474.7 5266.5 5281.6 5302.8 5335.5 5383.2 5582.2 5649.3 5677.4 5685.2 5775.1 6219.3 6252.2 6269.9 6283.6 6314.4 6045.8 6249.1 6281.1 6290.7 6330.8 6020.3 6035.2 6057.2 6064.3 6075.1 6282.2 6382.7 6408.8 6410.5 6432.2 6203.4 6272.5 6279.9 6282.0 6309.6 6256.7 6276.6 6310.9 6312.7 6324.4 6022.4 6203.7 6244.6 6263.0 6268.0 5265.8 6242.8 6258.7 6286.9 6296.6 4995.7 5010.9 5053.9 5056.8 5061.8 4485.5 4518.2 4573.3 4636.6 4639.4 4737.2 5817.4 5868.3 5879.8 5999.0 6237.9 6303.0 6307.1 6320.6 6326.8 5943.5 6025.4 6088.8 6106.7 6116.8 5538.8 5545.6 5547.1 5549.3 5568.8 6488.2 6500.2 6502.3 6524.4 6534.6 6184.9 6237.5 6290.7 6292.2 6345.7 6474.8 6498.3 6506.1 6507.9 6536.0 6219.3 6285.0 6286.7 6288.2 6330.5 6221.9 6262.5 6284.3 6340.7 6342.7 6177.7 6261.4 6264.0 6271.7 6304.2 6137.3 6262.4 6285.9 6289.0 6312.6 5889.6 6088.3 6114.7 6125.8 6163.9 6203.1 6222.2 6226.8 6234.9 6264.9 6088.1 6118.6 6193.3 6199.9 6255.3 12:22:52 INFO - PROCESS | 1677 | 12:22:52 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:66108.53 Median:20027.53 stddev:147919.80 (738.6%) stddev-sans-first:148252.83 12:22:52 INFO - PROCESS | 1677 | Values: 542.2 568.0 571.6 572.4 589.7 34202.0 39626.2 40814.4 41534.8 41559.0 32477.4 42960.6 43815.0 43821.1 43993.6 9711.0 9911.4 9920.1 9928.3 9936.8 9719.9 9885.0 9952.5 10009.7 10032.2 9854.2 9886.9 9915.8 10003.2 10030.9 9837.3 9862.3 9878.3 9986.3 9998.7 9775.5 9795.9 9895.1 9900.3 9929.5 34403.1 41315.8 41414.4 41965.6 43596.3 3102.7 3222.8 3330.8 3471.3 3840.0 27074.5 27547.9 27686.2 27764.4 28147.6 2633.6 2696.2 2716.6 2734.7 2774.1 330741.0 336193.0 336471.0 336836.0 338493.0 37594.0 37804.2 37804.2 37942.6 38641.8 35554.1 35619.9 35626.0 36337.3 36510.6 16364.0 16615.8 16849.3 16870.9 16879.9 13832.7 13851.6 13973.3 14203.5 14257.9 8704.0 8777.5 8784.4 8827.0 8843.6 3264.2 3523.6 3585.4 3637.6 3650.3 1032.5 1054.6 1142.8 1207.7 1235.9 30241.0 31252.0 31608.7 31940.0 32152.7 1185.1 1187.7 1192.5 1226.7 1245.7 13566.6 15881.3 16130.7 16183.3 16360.8 658897.0 660647.0 665132.0 668446.0 671552.0 66140.7 66375.7 66562.7 66783.0 66876.0 1363.3 1561.2 1582.6 1587.0 1680.3 30192.8 30899.2 30955.8 31233.5 31453.2 57712.4 57874.1 57951.7 58039.4 58124.0 593790.0 597293.0 597833.0 598148.0 598877.0 27943.4 28427.4 28533.6 28600.9 28773.6 48968.5 49415.5 49853.8 50459.2 50528.7 36404.7 36832.1 39361.0 39513.0 39833.4 38669.4 38767.2 39587.8 40048.4 40570.8 34128.1 39355.4 39398.8 40093.0 40572.8 32873.0 34117.7 34323.5 34676.7 34929.0 21145.3 21569.8 25795.1 26076.7 26686.9 12:22:52 INFO - PROCESS | 1677 | 12:22:52 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:36243.10 Median:2259.70 stddev:105096.87 (4650.9%) stddev-sans-first:105357.17 12:22:52 INFO - PROCESS | 1677 | Values: 363.6 376.5 411.4 415.4 419.3 15694.6 20899.0 21375.3 21543.5 21749.2 21573.6 21862.7 22303.0 22408.9 23030.4 5991.9 5996.5 6302.7 6316.2 6333.4 6117.3 6156.2 6238.4 6254.4 6264.0 5356.6 5995.9 6191.1 6233.4 6296.6 5180.4 5228.6 6106.8 6162.3 6220.5 5201.9 5477.8 5509.9 5549.0 5566.4 27721.9 27884.0 27927.0 27930.9 28416.3 2244.4 2275.0 2286.9 2295.7 2742.9 15001.1 15713.3 15849.9 15920.8 16367.9 1854.1 1867.3 1882.9 1887.5 1904.1 78794.6 81394.8 82361.6 112356.4 112655.0 9424.3 11884.0 12261.3 12289.1 12512.8 15632.9 15672.8 15958.7 15992.5 16035.9 8018.6 9020.1 9503.4 9542.9 9620.4 7875.1 9224.6 9389.0 9591.2 9603.8 4903.9 4946.8 4964.7 5003.8 5024.8 2055.1 2099.8 2120.9 2139.7 2172.0 947.9 1055.6 1066.6 1067.6 1077.1 16366.0 17142.5 20400.4 21021.8 21837.9 1000.0 1011.9 1033.8 1039.9 1042.5 11304.4 11551.0 11569.1 11583.5 11619.5 544407.0 632450.0 642380.0 650770.0 680725.0 136017.3 141186.0 141415.0 142331.0 148142.3 1070.0 1085.5 1101.9 1142.7 1143.4 15534.3 19603.0 19926.0 20246.4 20675.7 43511.6 56558.6 57358.4 57767.0 57987.1 81393.6 83047.2 83642.0 84511.2 85406.0 8586.3 8607.1 8703.4 8754.6 8805.1 9475.5 12825.6 13143.3 13393.7 13400.4 11289.8 11393.1 11552.6 11740.8 11763.7 11198.8 11366.0 11513.7 11687.9 11897.0 9537.5 11465.8 11548.0 11661.4 11907.6 8447.0 8642.7 8691.2 8712.0 8809.3 8733.8 9233.5 10981.0 11080.7 11238.9 12:22:52 INFO - PROCESS | 1677 | 12:22:52 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:5944.91 Median:2574.21 stddev:3335.25 (129.6%) stddev-sans-first:3328.72 12:22:52 INFO - PROCESS | 1677 | Values: 1614.1 1622.6 1930.8 2027.4 2044.7 8340.0 8920.7 9058.5 9236.0 9275.8 9075.6 9121.1 9188.2 9207.0 9211.9 2503.8 2504.7 2509.1 2527.1 2537.1 2465.6 2540.0 2541.1 2541.5 2542.5 2526.7 2533.8 2574.9 2578.4 2585.4 2206.7 2501.9 2526.4 2553.4 2562.1 2527.6 2548.6 2551.9 2554.0 2561.6 9133.4 9232.6 9262.0 9272.4 9281.5 5631.9 5643.9 5655.9 5675.1 5805.4 3445.6 3555.2 3641.6 3714.4 3768.3 1064.2 1069.2 1074.0 1082.6 1085.1 12270.6 12550.6 12580.6 12598.9 12609.5 4906.0 4964.0 5059.0 5083.9 5091.0 10597.5 10598.9 10606.5 10614.6 10619.0 5612.9 5625.9 5634.0 5679.5 5682.2 4681.5 5099.7 5180.4 5189.0 5245.0 4180.6 4205.0 4242.9 4274.5 4282.4 1370.6 1390.6 1400.3 1402.1 1404.5 924.6 939.2 959.3 975.6 990.3 6120.0 6131.4 6257.5 6272.5 6282.7 463.5 466.9 473.5 1049.4 1051.6 3635.9 3936.5 3999.0 4060.8 4091.2 10874.9 10998.9 11326.9 11348.9 11395.7 10924.9 10947.6 10976.7 11027.4 11072.3 6934.8 8614.6 8626.5 8737.9 8804.1 5929.3 5951.4 6012.4 6021.5 6051.4 9989.6 10083.5 10099.7 10202.0 10324.5 10080.7 10483.4 10575.0 10636.7 10725.7 6663.7 7098.3 7321.8 7353.0 7460.9 8598.1 8627.4 8645.8 8647.3 8671.7 7501.7 7659.0 7666.0 7697.2 7831.3 7494.3 7509.5 7518.8 7556.5 7653.5 7357.0 7371.7 7386.5 7391.2 7403.6 4387.8 5003.8 5008.7 5043.5 5170.4 4486.5 4590.5 5245.3 5254.9 5336.4 12:22:52 INFO - PROCESS | 1677 | 12:22:52 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:6067.91 Median:6911.52 stddev:1983.71 (28.7%) stddev-sans-first:1940.97 12:22:52 INFO - PROCESS | 1677 | Values: 270.7 329.2 336.2 339.7 341.7 6939.7 6957.5 6958.4 6967.2 6988.7 6848.2 6854.8 6865.5 6912.9 6976.3 4848.6 4902.6 5036.0 5053.8 5054.2 4993.2 5042.8 5044.3 5051.7 5063.6 4966.2 4988.9 4991.5 5015.8 5026.0 5003.1 5020.2 5026.7 5042.9 5048.8 4326.2 4343.2 4343.8 4349.8 4352.7 4943.4 6583.4 6602.6 6622.1 6642.2 5853.5 5890.9 5897.2 5899.3 5934.2 7374.0 7375.5 7391.7 7406.8 7409.2 4695.5 4700.8 4701.6 4709.0 4712.8 7520.4 7696.9 7768.8 7780.9 7840.6 4490.5 4778.7 4809.6 4825.4 4828.5 4894.5 4900.9 4905.0 4919.0 4931.8 5925.0 5938.1 5946.8 5955.8 5972.9 6655.0 6869.9 7458.3 7471.7 7487.4 1635.5 1678.3 1699.5 1701.7 1707.7 1058.6 1065.0 1071.6 1076.0 1077.2 6545.2 6724.8 6870.7 6910.1 6975.4 7488.3 7632.7 7695.1 7696.2 7706.9 6962.1 6991.2 7050.4 7052.1 7066.1 3528.7 3963.7 4095.0 4132.0 4146.5 8143.7 8173.8 8187.3 8190.7 8196.0 7850.6 7965.5 8100.8 8111.0 8117.0 8136.5 8154.3 8167.3 8173.6 8173.6 7811.6 7849.4 7852.6 7858.8 7869.3 5898.6 7141.5 7640.5 7643.5 7684.2 6932.4 7529.9 8227.2 8234.9 8246.3 4793.1 4852.4 4860.1 4882.4 4897.1 7765.6 7784.6 7784.6 7800.9 7820.6 5714.7 7509.8 7518.5 7527.0 7562.7 7494.9 7499.3 7502.0 7523.4 7545.5 7422.6 7493.1 7499.0 7522.8 7536.2 7492.1 7503.4 7538.4 7559.2 7559.5 7107.0 7303.3 7326.7 7356.2 7357.7 12:22:52 INFO - PROCESS | 1677 | 12:22:52 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:18927.48 Median:619.82 stddev:27196.97 (4387.9%) stddev-sans-first:27238.94 12:22:52 INFO - PROCESS | 1677 | Values: 731.1 747.7 750.2 758.9 772.4 15452.5 15708.2 15770.8 15818.8 15836.9 14463.2 14504.3 14508.3 14530.8 14551.9 761.7 902.0 915.1 915.9 916.0 903.9 919.2 919.3 921.1 943.0 824.0 956.8 982.0 985.8 1011.0 978.8 987.3 987.9 988.9 1000.0 752.3 756.2 757.6 758.6 761.6 15244.8 15280.7 15526.0 15720.8 15796.0 13350.0 13486.2 13491.5 13585.8 13608.2 10050.0 10329.2 10335.3 10422.4 10664.5 3556.8 3613.4 3619.4 3678.4 3680.2 82801.6 82838.8 83772.0 84112.6 84123.0 9724.6 9774.0 9788.7 9872.7 10449.4 22881.0 23776.0 23813.5 23833.9 23851.3 7167.4 7395.0 7455.4 7763.2 7844.3 3524.6 4098.5 4135.8 4147.5 4329.4 3366.4 3753.0 3756.4 3833.2 3865.4 652.9 670.3 671.5 680.2 680.6 527.7 567.2 589.0 615.1 618.9 6584.5 7883.4 8182.9 8282.3 8522.7 487.4 528.6 555.7 620.8 624.3 3845.7 3965.9 3981.8 4067.2 4211.6 99575.5 99577.0 99716.0 100160.0 101057.0 63786.0 83826.0 83899.0 84388.6 87181.0 72972.6 73451.6 74102.9 74933.6 76393.6 7966.0 8140.7 8179.6 8191.4 8248.1 51678.5 52050.7 52133.2 52207.7 55136.7 56040.0 70854.3 72209.6 73883.9 74929.3 10145.3 10198.2 10213.7 10235.4 10409.5 11377.5 11383.1 11464.5 11515.8 11563.2 10040.2 10192.3 10197.4 10344.9 10685.8 10602.3 10780.0 10781.8 10982.7 11025.3 9734.5 9992.5 10214.5 10327.1 10671.8 7765.7 9130.0 9243.7 9312.9 9698.8 9238.2 9409.4 9416.8 9417.3 9446.0 12:22:52 INFO - PROCESS | 1677 | -------- Summary: end -------- 12:22:52 INFO - PROCESS | 1677 | 12:22:53 INFO - TEST-INFO | 1677: exit 0 12:22:53 INFO - TEST-OK | dromaeo_css | took 1109607ms 12:22:53 INFO - TEST-START | kraken 12:22:53 INFO - operating with platform_type : mac_ 12:22:53 INFO - Initialising browser for kraken test... 12:22:53 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpImI4Zv/profile http://localhost:49275/getInfo.html) 12:22:55 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 12:22:55 INFO - PROCESS | 1684 | colorDepth:24 12:22:55 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 12:22:55 INFO - PROCESS | 1684 | __metrics 12:22:55 ERROR - PROCESS | 1684 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 12:22:56 INFO - TEST-INFO | 1684: exit 0 12:22:56 INFO - Browser initialized. 12:22:56 INFO - Running cycle 1/1 for kraken test... 12:22:56 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpImI4Zv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:23:08 INFO - PROCESS | 1688 | RSS: Main: 170831872 12:23:08 INFO - PROCESS | 1688 | 12:23:11 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 12:23:11 INFO - PROCESS | 1688 | RSS: Main: 183562240 12:23:11 INFO - PROCESS | 1688 | 12:23:14 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 12:23:15 INFO - PROCESS | 1688 | RSS: Main: 192233472 12:23:15 INFO - PROCESS | 1688 | 12:23:18 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 12:23:19 INFO - PROCESS | 1688 | RSS: Main: 195719168 12:23:19 INFO - PROCESS | 1688 | 12:23:21 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 12:23:21 INFO - PROCESS | 1688 | RSS: Main: 196055040 12:23:21 INFO - PROCESS | 1688 | 12:23:23 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:23:24 INFO - PROCESS | 1688 | RSS: Main: 198045696 12:23:24 INFO - PROCESS | 1688 | 12:23:27 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 12:23:27 INFO - PROCESS | 1688 | RSS: Main: 198602752 12:23:27 INFO - PROCESS | 1688 | 12:23:30 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 12:23:31 INFO - PROCESS | 1688 | RSS: Main: 198352896 12:23:31 INFO - PROCESS | 1688 | 12:23:34 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 12:23:34 INFO - PROCESS | 1688 | RSS: Main: 198418432 12:23:34 INFO - PROCESS | 1688 | 12:23:36 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:23:37 INFO - PROCESS | 1688 | RSS: Main: 197771264 12:23:37 INFO - PROCESS | 1688 | 12:23:38 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:23:39 INFO - PROCESS | 1688 | RSS: Main: 197738496 12:23:39 INFO - PROCESS | 1688 | 12:23:41 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:23:42 INFO - PROCESS | 1688 | RSS: Main: 197894144 12:23:42 INFO - PROCESS | 1688 | 12:23:45 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:23:45 INFO - PROCESS | 1688 | RSS: Main: 198049792 12:23:45 INFO - PROCESS | 1688 | 12:23:48 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:23:49 INFO - PROCESS | 1688 | RSS: Main: 197963776 12:23:49 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 12:23:51 INFO - PROCESS | 1688 | RSS: Main: 199729152 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | __start_tp_report 12:23:51 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 12:23:51 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 12:23:51 INFO - PROCESS | 1688 | |i|pagename|runs| 12:23:51 INFO - PROCESS | 1688 | |0;ai-astar;117;111;118;118;118;133;118;116;120;117 12:23:51 INFO - PROCESS | 1688 | |1;audio-beat-detection;154;125;145;190;155;149;177;154;169;123 12:23:51 INFO - PROCESS | 1688 | |2;audio-dft;194;196;198;202;195;199;200;195;198;197 12:23:51 INFO - PROCESS | 1688 | |3;audio-fft;63;83;75;137;56;55;62;67;128;61 12:23:51 INFO - PROCESS | 1688 | |4;audio-oscillator;77;79;128;79;88;93;101;106;121;162 12:23:51 INFO - PROCESS | 1688 | |5;imaging-gaussian-blur;93;90;124;107;93;90;93;90;92;89 12:23:51 INFO - PROCESS | 1688 | |6;imaging-darkroom;151;127;97;98;97;97;98;98;97;99 12:23:51 INFO - PROCESS | 1688 | |7;imaging-desaturate;91;93;91;89;100;88;97;144;90;90 12:23:51 INFO - PROCESS | 1688 | |8;json-parse-financial;57;62;63;62;64;65;64;79;63;61 12:23:51 INFO - PROCESS | 1688 | |9;json-stringify-tinderbox;64;66;76;68;70;71;69;64;65;68 12:23:51 INFO - PROCESS | 1688 | |10;stanford-crypto-aes;84;105;101;88;81;82;93;66;85;109 12:23:51 INFO - PROCESS | 1688 | |11;stanford-crypto-ccm;150;146;152;125;127;134;145;140;144;141 12:23:51 INFO - PROCESS | 1688 | |12;stanford-crypto-pbkdf2;220;216;234;220;214;173;163;166;183;206 12:23:51 INFO - PROCESS | 1688 | |13;stanford-crypto-sha256-iterative;66;69;66;67;68;70;65;67;70;67 12:23:51 INFO - PROCESS | 1688 | __end_tp_report 12:23:51 INFO - PROCESS | 1688 | __start_cc_report 12:23:51 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,1047 12:23:51 INFO - PROCESS | 1688 | __end_cc_report 12:23:51 INFO - PROCESS | 1688 | __startTimestamp1467141831391__endTimestamp 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | ------- Summary: start ------- 12:23:51 INFO - PROCESS | 1688 | Number of tests: 14 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | [#0] ai-astar Cycles:10 Average:118.60 Median:118.00 stddev:5.58 (4.7%) stddev-sans-first:5.89 12:23:51 INFO - PROCESS | 1688 | Values: 117.0 111.0 118.0 118.0 118.0 133.0 118.0 116.0 120.0 117.0 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | [#1] audio-beat-detection Cycles:10 Average:154.10 Median:154.50 stddev:20.97 (13.6%) stddev-sans-first:22.25 12:23:51 INFO - PROCESS | 1688 | Values: 154.0 125.0 145.0 190.0 155.0 149.0 177.0 154.0 169.0 123.0 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | [#2] audio-dft Cycles:10 Average:197.40 Median:198.00 stddev:2.50 (1.3%) stddev-sans-first:2.33 12:23:51 INFO - PROCESS | 1688 | Values: 194.0 196.0 198.0 202.0 195.0 199.0 200.0 195.0 198.0 197.0 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | [#3] audio-fft Cycles:10 Average:78.70 Median:62.50 stddev:29.65 (47.4%) stddev-sans-first:30.90 12:23:51 INFO - PROCESS | 1688 | Values: 63.0 83.0 75.0 137.0 56.0 55.0 62.0 67.0 128.0 61.0 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:78.00 stddev:27.07 (34.7%) stddev-sans-first:26.97 12:23:51 INFO - PROCESS | 1688 | Values: 77.0 79.0 128.0 79.0 88.0 93.0 101.0 106.0 121.0 162.0 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | [#5] imaging-gaussian-blur Cycles:10 Average:96.10 Median:91.00 stddev:11.08 (12.2%) stddev-sans-first:11.70 12:23:51 INFO - PROCESS | 1688 | Values: 93.0 90.0 124.0 107.0 93.0 90.0 93.0 90.0 92.0 89.0 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | [#6] imaging-darkroom Cycles:10 Average:105.90 Median:97.50 stddev:18.35 (18.8%) stddev-sans-first:9.82 12:23:51 INFO - PROCESS | 1688 | Values: 151.0 127.0 97.0 98.0 97.0 97.0 98.0 98.0 97.0 99.0 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:90.50 stddev:16.83 (18.6%) stddev-sans-first:17.69 12:23:51 INFO - PROCESS | 1688 | Values: 91.0 93.0 91.0 89.0 100.0 88.0 97.0 144.0 90.0 90.0 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:63.50 stddev:5.72 (9.0%) stddev-sans-first:5.47 12:23:51 INFO - PROCESS | 1688 | Values: 57.0 62.0 63.0 62.0 64.0 65.0 64.0 79.0 63.0 61.0 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.50 stddev:3.70 (5.4%) stddev-sans-first:3.61 12:23:51 INFO - PROCESS | 1688 | Values: 64.0 66.0 76.0 68.0 70.0 71.0 69.0 64.0 65.0 68.0 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:83.00 stddev:12.90 (15.5%) stddev-sans-first:13.54 12:23:51 INFO - PROCESS | 1688 | Values: 84.0 105.0 101.0 88.0 81.0 82.0 93.0 66.0 85.0 109.0 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:144.50 stddev:9.13 (6.3%) stddev-sans-first:9.00 12:23:51 INFO - PROCESS | 1688 | Values: 150.0 146.0 152.0 125.0 127.0 134.0 145.0 140.0 144.0 141.0 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.50 Median:215.00 stddev:25.79 (12.0%) stddev-sans-first:26.26 12:23:51 INFO - PROCESS | 1688 | Values: 220.0 216.0 234.0 220.0 214.0 173.0 163.0 166.0 183.0 206.0 12:23:51 INFO - PROCESS | 1688 | 12:23:51 INFO - PROCESS | 1688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.72 (2.5%) stddev-sans-first:1.73 12:23:51 INFO - PROCESS | 1688 | Values: 66.0 69.0 66.0 67.0 68.0 70.0 65.0 67.0 70.0 67.0 12:23:51 INFO - PROCESS | 1688 | -------- Summary: end -------- 12:23:51 INFO - PROCESS | 1688 | 12:23:52 INFO - TEST-INFO | 1688: exit 0 12:23:52 INFO - TEST-OK | kraken | took 58811ms 12:23:52 INFO - SUITE-END | took 1168s 12:23:52 INFO - Completed test suite (00:19:28) 12:23:52 INFO - javascript benchmark 12:23:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2800.285927088593, 3662.9084272893174, 3690.926181476372, 3695.9630403695965, 3710.183759572895, 5927.199828023216, 5929.673867937262, 5977.7011149442515, 5979.880402391944, 5982.312034116078, 4956.603471722263, 5990.670513121777, 6006.939930600693, 6007.219061522007, 6009.399060093989, 5292.788288468466, 5365.275687782158, 5406.270153529283, 5456.372517160537, 5515.696636684981, 5337.839864804062, 5400.891982160354, 5401.162819762943, 5449.809256676017, 5518.751656175462, 5454.699991500466, 5486.451354864502, 5494.752736126884, 5511.118221084627, 5519.806806761764, 5337.813176538842, 5456.590755693339, 5467.9453205467835, 5470.343558772933, 5474.671519708831, 5266.473352664703, 5281.551068159211, 5302.787888484456, 5335.546478549328, 5383.2194331821665, 5582.246396736429, 5649.322081350223, 5677.40387259336, 5685.1756495307945, 5775.104858746859, 6219.315875253718, 6252.18721566198, 6269.905951410732, 6283.622982621057, 6314.431701146873, 6045.818625441244, 6249.0626406039, 6281.089242059876, 6290.654014029226, 6330.8100756977365, 6020.307664618537, 6035.245594300713, 6057.151998720183, 6064.272287325549, 6075.149479072933, 6282.151909492251, 6382.680865956683, 6408.775692850728, 6410.487161027107, 6432.228132624022, 6203.379662033761, 6272.498200143978, 6279.905801412982, 6281.96859015702, 6309.589876658094, 6256.6871656417, 6276.623402595859, 6310.873782524323, 6312.684365781693, 6324.367563243731, 6022.3676513966275, 6203.689815509297, 6244.625322480666, 6262.9666105093065, 6267.9971204607955, 5265.76304066318, 6242.843928901723, 6258.718357673915, 6286.937130628727, 6296.5592408531875, 4995.650304478651, 5010.872553675394, 5053.873653158627, 5056.84829455117, 5061.848144555669, 4485.529019452975, 4518.2319005769095, 4573.314002899591, 4636.582707556337, 4639.443266807937, 4737.194676904865, 5817.418258174233, 5868.325142608569, 5879.823605291848, 5999.0401535754945, 6237.906431403532, 6303.023031430135, 6307.148534947815, 6320.62076275425, 6326.810195694136, 5943.465088142001, 6025.367336429612, 6088.756449742049, 6106.694665266719, 6116.847078823065, 5538.833834984957, 5545.611807173459, 5547.084731019418, 5549.250851135126, 5568.777248910079, 6488.221413430419, 6500.187476565429, 6502.252240992252, 6524.445422139076, 6534.640594767334, 6184.876302474016, 6237.500999919905, 6290.748370065329, 6292.182016337847, 6345.714442850175, 6474.805755827333, 6498.317676643885, 6506.089147519446, 6507.902381464377, 6535.967320163369, 6219.315875253628, 6285.0, 6286.654234017173, 6288.245410550763, 6330.461910737639, 6221.906671399842, 6262.53031022666, 6284.340144284784, 6340.714667839866, 6342.682865856781, 6177.725342612316, 6261.436470717657, 6263.96868015657, 6271.749130034747, 6304.243490780952, 6137.315698287052, 6262.405071518198, 6285.874282514415, 6289.0, 6312.589681670676, 5889.5582831286965, 6088.299845517822, 6114.6636934969, 6125.84685382869, 6163.876722465615, 6203.131561581292, 6222.16000839899, 6226.844328891814, 6234.875302494015, 6264.906026409516, 6088.117223002551, 6118.632882027093, 6193.256809182927, 6199.907001394892, 6255.343188965275], "value": 5835.051574175737, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.2002546244288, 567.9862306368332, 571.6312978129107, 572.4218539275331, 589.6579983609505, 34202.0, 39626.216820243084, 40814.38778418326, 41534.792326038325, 41559.0, 32477.350452990926, 42960.570394296046, 43815.0, 43821.12357752843, 43993.560064399346, 9711.0, 9911.405315681046, 9920.057594528509, 9928.305018648698, 9936.801263974716, 9719.854202186973, 9884.950575247114, 9952.502374881227, 10009.749756256078, 10032.247581431386, 9854.211663066973, 9886.901130988706, 9915.801683966316, 10003.249756268273, 10030.890423968593, 9837.311388202828, 9862.260330475172, 9878.308518403715, 9986.300958932878, 9998.700038998806, 9775.462349570771, 9795.902040979641, 9895.059969302905, 9900.257480688904, 9929.503524823802, 34403.13992150191, 41315.793421033006, 41414.37878431826, 41965.58034419678, 43596.346054809204, 3102.689731026902, 3222.7582931280012, 3330.7501937354555, 3471.3057388522143, 3839.9616003840165, 27074.458510829674, 27547.898084076613, 27686.169414917586, 27764.444711105865, 28147.577786333222, 2633.604959256127, 2696.150712525548, 2716.578930265812, 2734.671839379287, 2774.1261502626608, 330741.0, 336193.0, 336470.99999999756, 336836.0, 338493.0, 37594.0, 37804.243915121544, 37804.2439151221, 37942.62057379391, 38641.806790965864, 35554.11114722101, 35619.93140205798, 35626.0, 36337.27325453476, 36510.63489365125, 16364.0, 16615.750763738553, 16849.32602695903, 16870.915645421694, 16879.91560042192, 13832.654183645489, 13851.584452466443, 13973.301334933212, 14203.502877399447, 14257.92871035659, 8704.0, 8777.517236551923, 8784.42901211432, 8827.0, 8843.646254149891, 3264.183954011497, 3523.612402635708, 3585.4084076127147, 3637.563492380931, 3650.3429382710838, 1032.4682788363998, 1054.6079175488435, 1142.8228624563205, 1207.704112492445, 1235.8640549539543, 30241.0, 31252.0, 31608.683913161032, 31940.04179874561, 32152.678473215437, 1185.057878986208, 1187.7268228307364, 1192.4991503568522, 1226.7055906582534, 1245.735578387937, 13566.644207522422, 15881.28534215963, 16130.677386452206, 16183.271752771154, 16360.754588681179, 658897.0, 660647.0, 665132.0, 668446.0, 671552.0, 66140.66929665321, 66375.66812166006, 66562.66718666472, 66783.0, 66876.0, 1363.3387806913638, 1561.1578337561787, 1582.5727053695439, 1586.9682606347808, 1680.3026743901144, 30192.84903575468, 30899.227519312197, 30955.761769528966, 31233.531497027107, 31453.213669657525, 57712.4228757707, 57874.13188802087, 57951.71024144852, 58039.4196058034, 58124.0, 593790.0, 597293.0, 597833.0, 598148.0, 598877.0056149692, 27943.441131177668, 28427.431451370445, 28533.571996420487, 28600.856995714887, 28773.568396473653, 48968.51031489782, 49415.50584494109, 49853.75073124611, 50459.243111352625, 50528.74735626298, 36404.725834595665, 36832.07919802026, 39361.0, 39513.0, 39833.40249896196, 38669.41995870008, 38767.224655506165, 39587.80206099066, 40048.3992740115, 40570.79714601408, 34128.14679633029, 39355.409668855566, 39398.80300598593, 40093.0, 40572.78281651555, 32873.0, 34117.65882341244, 34323.4851477233, 34676.65323346734, 34929.0, 21145.304093508534, 21569.78430215678, 25795.097171598904, 26076.73923260743, 26686.932522698873], "value": 18982.1546352833, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.5709862362413, 376.5011359948069, 411.38087178795905, 415.37900838246827, 419.2872117400419, 15694.607634809136, 20898.955052247384, 21375.251866184666, 21543.461413464673, 21749.238776642822, 21573.568528629417, 21862.672059919114, 22303.0, 22408.88795556024, 23030.424239394022, 5991.86154630621, 5996.460318571328, 6302.653354065525, 6316.178896743417, 6333.366663333676, 6117.327094019654, 6156.1996940397685, 6238.376162383748, 6254.374562543755, 6264.029075493283, 5356.598255130862, 5995.880082398349, 6191.102290167923, 6233.407826256498, 6296.559240853142, 5180.352455943007, 5228.633995620308, 6106.755729770848, 6162.322144564095, 6220.507078301198, 5201.895962080737, 5477.780888764445, 5509.889802203974, 5548.9722551386985, 5566.443355664442, 27721.86139069312, 27884.0, 27927.0, 27930.860345698344, 28416.28959276014, 2244.394013616331, 2275.0, 2286.8513546619415, 2295.678604995302, 2742.945141097187, 15001.099934003885, 15713.292901819332, 15849.92075039629, 15920.76118858218, 16367.85425020249, 1854.1470923375264, 1867.2997625890291, 1882.9246830126915, 1887.5375532994503, 1904.1145867171692, 78794.60602697007, 81394.77907831446, 82361.58819205925, 112356.4382178092, 112655.0, 9424.29317801154, 11884.0, 12261.26432414058, 12289.078319125923, 12512.81230781539, 15632.905696601356, 15672.843271567366, 15958.680826383408, 15992.520224393287, 16035.919820401057, 8018.5990700464745, 9020.097990201059, 9503.429794212369, 9542.902566204975, 9620.422774633544, 7875.133735289113, 9224.631014759469, 9389.0, 9591.232701384011, 9603.807923841485, 4903.915835769783, 4946.777395017233, 4964.726940018261, 5003.774830132653, 5024.84925452237, 2055.0715230796054, 2099.7847271129103, 2120.8971334905764, 2139.6677621392755, 2172.0, 947.9336446448682, 1055.625253035177, 1066.5520481397832, 1067.631667074858, 1077.1221454514546, 16366.018038917702, 17142.485725428258, 20400.387988360373, 21021.78978210229, 21837.890810545847, 1000.0449121966537, 1011.8532812742111, 1033.7725700345911, 1039.8856125826153, 1042.4527123260198, 11304.378259195822, 11550.96041356282, 11569.132315076404, 11583.536658533565, 11619.535218591162, 544407.0, 632450.0, 642380.0, 650770.0, 680725.0, 136017.3199133998, 141186.0, 141415.0, 142331.0, 148142.29644258766, 1070.0369667299337, 1085.5169449595012, 1101.9393933333583, 1142.702897246722, 1143.3711458697683, 15534.300956457213, 19603.0, 19926.0, 20246.392608221777, 20675.68986465174, 43511.56488435202, 56558.58603534944, 57358.42641573531, 57767.0, 57987.13019304798, 81393.59303203446, 83047.16952830394, 83642.0, 84511.15488845033, 85406.0, 8586.313094952264, 8607.096254893146, 8703.43427677199, 8754.649814007369, 8805.119488051143, 9475.526223688927, 12825.615231542695, 13143.342832858127, 13393.732125357243, 13400.396982136022, 11289.774204516028, 11393.08855291558, 11552.59565915189, 11740.765184696429, 11763.705907352043, 11198.832017519906, 11366.0, 11513.654590362303, 11687.941560292144, 11897.048236141261, 9537.47543885093, 11465.770684586094, 11548.018418434527, 11661.35862527569, 11907.642770716893, 8446.957765211135, 8642.654293828176, 8691.174338437839, 8712.0, 8809.339299552432, 8733.781655458664, 9233.49215793111, 10981.0, 11080.67031956138, 11238.943805280922], "value": 10042.9279072393, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1614.112238268952, 1622.6267958369572, 1930.758655168104, 2027.4019164346525, 2044.7341845560074, 8340.040895297043, 8920.73237802867, 9058.501782401965, 9236.0, 9275.76810579735, 9075.591598378072, 9121.133492318218, 9188.219001384874, 9207.0, 9211.90788092119, 2503.7621425964503, 2504.686914135733, 2509.121807367425, 2527.140772137473, 2537.13737329308, 2465.5561998840203, 2540.0220914947786, 2541.0852093246417, 2541.5298169838547, 2542.4915016996583, 2526.68416447944, 2533.809964252679, 2574.948501029978, 2578.40696639773, 2585.418280886804, 2206.6910632511463, 2501.94918134384, 2526.418923647553, 2553.3871870750977, 2562.052040744927, 2527.6082207257905, 2548.5922252439523, 2551.9106831260815, 2554.029468801862, 2561.5645340292194, 9133.36066475347, 9232.584533696, 9262.027487113823, 9272.397294175857, 9281.53592320388, 5631.943680563224, 5643.915341269884, 5655.943440565583, 5675.063614503602, 5805.36141024487, 3445.620981692012, 3555.1645363339853, 3641.563012438498, 3714.4428335749585, 3768.3405404054456, 1064.2071656615794, 1069.219469787052, 1074.044100750325, 1082.5994382078602, 1085.066842515436, 12270.570530031406, 12550.623481295575, 12580.559680411234, 12598.874011259953, 12609.495620175181, 4905.975470122627, 4964.0, 5058.974705126451, 5083.949160508421, 5090.974545127251, 10597.523111460003, 10598.947005264925, 10606.522706478227, 10614.628488002883, 10618.991195836383, 5612.859678507988, 5625.859353516113, 5634.0, 5679.488846003879, 5682.176084467729, 4681.531846815291, 5099.745012749348, 5180.404253510819, 5188.9740551297, 5244.973775131176, 4180.644645205191, 4205.0, 4242.915141697149, 4274.529801721808, 4282.443282373271, 1370.6293706293707, 1390.5897760160776, 1400.271858633505, 1402.1236727045596, 1404.4803422733653, 924.5977999570208, 939.2392162348519, 959.3092973059386, 975.5902520941222, 990.3414229537277, 6120.0, 6131.356207598227, 6257.530685198628, 6272.466840318532, 6282.717277722513, 463.54109431662414, 466.8786115609966, 473.47917290980337, 1049.4437947887632, 1051.5636011055326, 3635.8728794073922, 3936.5079365079364, 3999.0, 4060.7766572838777, 4091.2022155679356, 10874.945625271823, 10998.945005274922, 11326.943365283121, 11348.943255283672, 11395.746467888526, 10924.890751092546, 10947.56209751601, 10976.725581860357, 11027.44862756859, 11072.280301780358, 6934.757283495053, 8614.612342444605, 8626.525541095174, 8737.912620873836, 8804.075572065098, 5929.288485381781, 5951.434613711864, 6012.398760123952, 6021.54838387114, 6051.364606716232, 9989.60041598328, 10083.546240419051, 10099.69700908974, 10202.0, 10324.48377581133, 10080.69757907264, 10483.423411712429, 10575.0, 10636.680899573024, 10725.731856703645, 6663.666816659051, 7098.3256590623805, 7321.78034658961, 7353.0, 7460.925390746023, 8598.097199794182, 8627.396082274181, 8645.783855403664, 8647.308215342884, 8671.696490622799, 7501.662425190771, 7658.961705191438, 7666.0, 7697.230276972258, 7831.334336581226, 7494.288042635941, 7509.549427034395, 7518.774436766906, 7556.546607203585, 7653.540787552764, 7357.043584334217, 7371.668274927534, 7386.519876208029, 7391.1869694334655, 7403.5928023959195, 4387.802548885244, 5003.849884503471, 5008.724520151281, 5043.470435604208, 5170.43125256214, 4486.50648428666, 4590.472095709036, 5245.265662807286, 5254.947450525446, 5336.412994570516], "value": 4762.458834579159, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.7171006298418, 329.20825414877214, 336.21493811949097, 339.65864306372094, 341.68223552096555, 6939.653017349125, 6957.547759395648, 6958.408535274495, 6967.198772141205, 6988.685509152087, 6848.246692863793, 6854.82862928427, 6865.485088618361, 6912.930870691304, 6976.337247961435, 4848.563629273356, 4902.558769710726, 5036.017976494585, 5053.84838454847, 5054.241863720453, 4993.176125939216, 5042.773075211624, 5044.319016932704, 5051.747412629354, 5063.594912407017, 4966.230234313687, 4988.925166122511, 4991.450940396553, 5015.824446144386, 5025.994801039788, 5003.14946459101, 5020.2218656108, 5026.673266237683, 5042.949570504321, 5048.7728052237735, 4326.178026175016, 4343.2399330117105, 4343.826246950118, 4349.80425880833, 4352.737706065237, 4943.431505376891, 6583.407493325576, 6602.570832895846, 6622.139121914169, 6642.169728783902, 5853.473187413153, 5890.852728681774, 5897.233359663259, 5899.262592175978, 5934.228550288478, 7374.041374621265, 7375.520591161611, 7391.704331826721, 7406.814829629248, 7409.222031686649, 4695.483496815347, 4700.788464519105, 4701.553352431513, 4709.011107667394, 4712.764361781931, 7520.398368130536, 7696.884546731803, 7768.844623107506, 7780.922190778077, 7840.607969601497, 4490.528494508095, 4778.665493415428, 4809.615230781529, 4825.445073816556, 4828.517148285214, 4894.510548945077, 4900.921797204609, 4904.975475122602, 4918.9508104919205, 4931.778069986859, 5925.022371308686, 5938.138969849434, 5946.762129514771, 5955.7617695292565, 5972.880542389128, 6654.966725166343, 6869.900815869437, 7458.29146231118, 7471.738489152854, 7487.401007919353, 1635.4602981016237, 1678.2867281405597, 1699.4646686293777, 1701.7447382892665, 1707.6670049340507, 1058.6347710040025, 1064.9520771565299, 1071.603506702525, 1076.0476977874637, 1077.1867240233573, 6545.214574251025, 6724.798256052326, 6870.690818913161, 6910.101686780687, 6975.372216500539, 7488.251174882577, 7632.732854350183, 7695.115061767969, 7696.190385759085, 7706.922930770733, 6962.1297337832775, 6991.161060672752, 7050.435965122778, 7052.118485189351, 7066.116735408074, 3528.6647768461953, 3963.722539422213, 4095.0, 4131.975332087256, 4146.543880173179, 8143.714969976022, 8173.754787356389, 8187.304079153219, 8190.672373105009, 8196.0, 7850.582788915259, 7965.522068675898, 8100.797480063045, 8110.959445202736, 8116.959415202886, 8136.471129376571, 8154.306883914934, 8167.264946154874, 8173.550454724928, 8173.610486217239, 7811.570363630055, 7849.411294153076, 7852.646630901509, 7858.764237072897, 7869.252421019994, 5898.587098903207, 7141.535800172972, 7640.541567505968, 7643.541387516767, 7684.193159718149, 6932.376086152271, 7529.87051942213, 8227.177282271725, 8234.917650823416, 8246.257836794717, 4793.089313030513, 4852.393450818648, 4860.149473841992, 4882.389701287339, 4897.118518666674, 7765.572893490912, 7784.5718485481575, 7784.649690763816, 7800.921990780246, 7820.569868657051, 5714.714264286852, 7509.849803004018, 7518.473706840468, 7526.962365188139, 7562.697492100475, 7494.850102997801, 7499.2500749924575, 7502.0, 7523.360514356341, 7545.547267163988, 7422.554646721214, 7493.063367079115, 7498.962505187439, 7522.849543009219, 7536.171021187774, 7492.063492063492, 7503.399728021636, 7538.359239464707, 7559.244075592397, 7559.5464272143845, 7106.964465177641, 7303.269673032654, 7326.706931722884, 7356.227596102332, 7357.668904899186], "value": 5391.6162543476385, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.1409094314181, 747.6897087708601, 750.2160242546538, 758.908930928288, 772.3898120484814, 15452.45916392925, 15708.21458927052, 15770.76343854843, 15818.76271855923, 15836.92081539592, 14463.204523751216, 14504.347304371302, 14508.347124379401, 14530.782038269408, 14551.92724036381, 761.6953218712532, 901.9819603607924, 915.1260546178416, 915.9404638698496, 915.9725208243764, 903.905089965554, 919.1957037592107, 919.3426699909563, 921.1479381572019, 942.9905700942971, 823.9629216685233, 956.8038552096838, 981.950902454878, 985.8126955878396, 1010.9898901011006, 978.7846673731767, 987.274353350287, 987.8567607696915, 988.9258305627106, 999.9900100898109, 752.289086812962, 756.1908757629338, 757.5984728094064, 758.6396461680713, 761.6077719974218, 15244.847551524565, 15280.694386112216, 15526.0, 15720.764188537181, 15796.0, 13349.998750093684, 13486.19082855022, 13491.527796527074, 13585.796213056812, 13608.183508989394, 10049.995000499965, 10329.225308101923, 10335.328203666737, 10422.374657520497, 10664.466776661136, 3556.822158892045, 3613.3857244268274, 3619.3666108431185, 3678.44823276508, 3680.190358121209, 82801.58599207025, 82838.75741863938, 83772.0, 84112.57943710242, 84123.0, 9724.562394692255, 9774.0, 9788.657396991071, 9872.654457093968, 10449.425281609432, 22881.0, 23776.0, 23813.523729525314, 23833.880830595735, 23851.284461466184, 7167.4266058715175, 7394.963025184948, 7455.366293864974, 7763.2236776321915, 7844.333231675258, 3524.6122926478065, 4098.549159592442, 4135.813888375031, 4147.460830092069, 4329.415528903621, 3366.4277072897667, 3753.0, 3756.417755247941, 3833.1758671885677, 3865.40086286626, 652.8922727749868, 670.2861452553016, 671.5332843673698, 680.2381332907175, 680.6188534420642, 527.6965744696814, 567.1804242869015, 589.0, 615.1129277887144, 618.8576627375729, 6584.539082264196, 7883.408744344082, 8182.936218291703, 8282.337413006944, 8522.69897090022, 487.4199702354187, 528.5982653183609, 555.6777069299796, 620.7796232337546, 624.3101372982879, 3845.7115716321387, 3965.8810235692977, 3981.7810020449156, 4067.186562687474, 4211.578842115764, 99575.50212248892, 99577.0, 99716.0, 100160.0, 101057.0, 63786.0, 83826.0, 83899.0, 84388.57805710932, 87181.0, 72972.63513682503, 73451.63274183594, 74102.88845667211, 74933.62533187299, 76393.61803190949, 7966.0, 8140.674373025013, 8179.631916563888, 8191.385646076687, 8248.092709802037, 51678.48321516737, 52050.73974630254, 52133.17533886296, 52207.73896130495, 55136.72431637816, 56040.0, 70854.29145708476, 72209.63895180491, 73883.89174162285, 74929.25070749223, 10145.28982971185, 10198.235132365251, 10213.693589192337, 10235.385876847413, 10409.47952602382, 11377.488013039267, 11383.146264030065, 11464.484098215768, 11515.769684606428, 11563.248388854698, 10040.196784257096, 10192.3374980629, 10197.388156710622, 10344.896551034695, 10685.839712404164, 10602.310849794738, 10780.0, 10781.784364312512, 10982.725431864268, 11025.283356581796, 9734.513274336396, 9992.500374981368, 10214.540345684314, 10327.122194613241, 10671.786564268516, 7765.72819951299, 9129.954350228472, 9243.722688319362, 9312.860307095263, 9698.806023879624, 9238.214751746176, 9409.388389754919, 9416.764580885532, 9417.293702972167, 9445.952770236105], "value": 6986.510123838164, "unit": "score"}], "name": "dromaeo_css", "value": 7644.500353730229, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 118.0, 118.0, 118.0, 133.0, 118.0, 116.0, 120.0, 117.0], "value": 118.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 145.0, 190.0, 155.0, 149.0, 177.0, 154.0, 169.0, 123.0], "value": 154.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 196.0, 198.0, 202.0, 195.0, 199.0, 200.0, 195.0, 198.0, 197.0], "value": 197.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 83.0, 75.0, 137.0, 56.0, 55.0, 62.0, 67.0, 128.0, 61.0], "value": 78.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 128.0, 79.0, 88.0, 93.0, 101.0, 106.0, 121.0, 162.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 90.0, 124.0, 107.0, 93.0, 90.0, 93.0, 90.0, 92.0, 89.0], "value": 96.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 97.0, 98.0, 97.0, 97.0, 98.0, 98.0, 97.0, 99.0], "value": 105.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 91.0, 89.0, 100.0, 88.0, 97.0, 144.0, 90.0, 90.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 62.0, 63.0, 62.0, 64.0, 65.0, 64.0, 79.0, 63.0, 61.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 76.0, 68.0, 70.0, 71.0, 69.0, 64.0, 65.0, 68.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 105.0, 101.0, 88.0, 81.0, 82.0, 93.0, 66.0, 85.0, 109.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 146.0, 152.0, 125.0, 127.0, 134.0, 145.0, 140.0, 144.0, 141.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 216.0, 234.0, 220.0, 214.0, 173.0, 163.0, 166.0, 183.0, 206.0], "value": 199.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 66.0, 67.0, 68.0, 70.0, 65.0, 67.0, 70.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1580.4, "alertThreshold": 2.0}]} 12:23:52 INFO - Return code: 0 12:23:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:23:52 ERROR - # TBPL SUCCESS # 12:23:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:23:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:23:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:23:52 INFO - 2016-06-28 12:23:52.724 screenresolution[1693:11753] starting screenresolution argv=screenresolution get 12:23:52 INFO - 2016-06-28 12:23:52.726 screenresolution[1693:11753] Display 0: 1600x1200x32@60 12:23:52 INFO - 2016-06-28 12:23:52.732 screenresolution[1694:11756] starting screenresolution argv=screenresolution list 12:23:52 INFO - Available Modes on Display 0 12:23:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:23:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:23:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:23:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:23:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:23:52 INFO - Intel Iris: 12:23:52 INFO - Chipset Model: Intel Iris 12:23:52 INFO - Type: GPU 12:23:52 INFO - Bus: Built-In 12:23:52 INFO - VRAM (Dynamic, Max): 1536 MB 12:23:52 INFO - Vendor: Intel (0x8086) 12:23:52 INFO - Device ID: 0x0a2e 12:23:52 INFO - Revision ID: 0x0009 12:23:52 INFO - Displays: 12:23:52 INFO - Display: 12:23:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:23:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:23:52 INFO - Display Serial Number: 1600x1200 60 12:23:52 INFO - Main Display: Yes 12:23:52 INFO - Mirror: Off 12:23:52 INFO - Online: Yes 12:23:52 INFO - Rotation: Supported 12:23:52 INFO - Return code: 0 12:23:52 INFO - Running post-action listener: _resource_record_post_action 12:23:52 INFO - Running post-run listener: _resource_record_post_run 12:23:54 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 32689664; Write bytes: 495873536; Read time: 326; Write time: 1829 12:23:54 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 194877952; Write bytes: 196556800; Read time: 18913; Write time: 459 12:23:54 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 30907904; Write bytes: 298468864; Read time: 307; Write time: 1367 12:23:54 INFO - Running post-run listener: _upload_blobber_files 12:23:54 INFO - Blob upload gear active. 12:23:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:23:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:23:54 INFO - (blobuploader) - INFO - Open directory for files ... 12:23:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:23:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:23:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:55 INFO - (blobuploader) - INFO - Done attempting. 12:23:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:23:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:23:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:56 INFO - (blobuploader) - INFO - Done attempting. 12:23:56 INFO - (blobuploader) - INFO - Iteration through files over. 12:23:56 INFO - Return code: 0 12:23:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:23:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:23:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e489a3dbb755b96b359b06d12efa810a316ef9141299eb47fd2d93b8aaa935a0424580e0365db162b189936f04557c7148b275f112d6313ea3594d4b7d57a494", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cddbbc2b3983743bc1abda3dfa2d16b5ab0155c9f71c4044ebaeee8531f8b69fcdc0d1f66804ff504a0ef9e7e5294138c37322436ff653d293cf3c94d5ae5d49"} 12:23:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:23:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:23:56 INFO - Contents: 12:23:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e489a3dbb755b96b359b06d12efa810a316ef9141299eb47fd2d93b8aaa935a0424580e0365db162b189936f04557c7148b275f112d6313ea3594d4b7d57a494", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cddbbc2b3983743bc1abda3dfa2d16b5ab0155c9f71c4044ebaeee8531f8b69fcdc0d1f66804ff504a0ef9e7e5294138c37322436ff653d293cf3c94d5ae5d49"} 12:23:56 INFO - Running post-run listener: copy_logs_to_upload_dir 12:23:56 INFO - Copying logs to upload dir... 12:23:56 INFO - mkdir: /builds/slave/test/build/upload/logs 12:23:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1368.161404 ========= master_lag: 0.61 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 48 secs) (at 2016-06-28 12:23:56.517769) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 12:23:56.521555) ========= 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.m8kvtV10Ln/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.eukJFkQtVK/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e489a3dbb755b96b359b06d12efa810a316ef9141299eb47fd2d93b8aaa935a0424580e0365db162b189936f04557c7148b275f112d6313ea3594d4b7d57a494", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cddbbc2b3983743bc1abda3dfa2d16b5ab0155c9f71c4044ebaeee8531f8b69fcdc0d1f66804ff504a0ef9e7e5294138c37322436ff653d293cf3c94d5ae5d49"} build_url:https://queue.taskcluster.net/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011050 build_url: 'https://queue.taskcluster.net/v1/task/VGzaNy_QS7mGc95tMnwJ7w/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e489a3dbb755b96b359b06d12efa810a316ef9141299eb47fd2d93b8aaa935a0424580e0365db162b189936f04557c7148b275f112d6313ea3594d4b7d57a494", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cddbbc2b3983743bc1abda3dfa2d16b5ab0155c9f71c4044ebaeee8531f8b69fcdc0d1f66804ff504a0ef9e7e5294138c37322436ff653d293cf3c94d5ae5d49"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 12:23:56.555151) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:23:56.555545) ========= 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.m8kvtV10Ln/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.eukJFkQtVK/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.005049 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:23:56.605503) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 12:23:56.605878) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 12:23:56.606416) ========= ========= Total master_lag: 2.82 =========