builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0141 starttime: 1466588421.85 results: success (0) buildid: 20160622010102 builduid: 15a2bdba63f94b45ac0a712a9a170911 revision: 800dc20aca781026226a03c3f43ff132b5cfdc1d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 02:40:21.848615) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 02:40:21.849200) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 02:40:21.849491) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 02:40:21.873980) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:40:21.874400) ========= 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.UQUlIApWOb/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.W1eoVFdBHR/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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-22 02:40:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.44M=0.001s 2016-06-22 02:40:21 (9.44 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110850 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:40:22.007350) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:40:22.007692) ========= 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.UQUlIApWOb/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.W1eoVFdBHR/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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.029458 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:40:22.058267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-22 02:40:22.058705) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 800dc20aca781026226a03c3f43ff132b5cfdc1d --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 800dc20aca781026226a03c3f43ff132b5cfdc1d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UQUlIApWOb/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.W1eoVFdBHR/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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-22 02:40:22,133 truncating revision to first 12 chars 2016-06-22 02:40:22,133 Setting DEBUG logging. 2016-06-22 02:40:22,133 attempt 1/10 2016-06-22 02:40:22,133 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/800dc20aca78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 02:40:24,046 unpacking tar archive at: mozilla-beta-800dc20aca78/testing/mozharness/ program finished with exit code 0 elapsedTime=2.167521 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-22 02:40:24.247825) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 02:40:24.248213) ========= script_repo_revision: 800dc20aca781026226a03c3f43ff132b5cfdc1d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 02:40:24.248680) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 02:40:24.248979) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 02:40:24.267072) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-22 02:40:24.267498) ========= /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.UQUlIApWOb/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.W1eoVFdBHR/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:40:24 INFO - MultiFileLogger online at 20160622 02:40:24 in /builds/slave/test 02:40:24 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 02:40:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:40:24 INFO - {'append_to_log': False, 02:40:24 INFO - 'base_work_dir': '/builds/slave/test', 02:40:24 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:40:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:40:24 INFO - 'branch': 'Mozilla-Beta', 02:40:24 INFO - 'buildbot_json_path': 'buildprops.json', 02:40:24 INFO - 'config_files': ('talos/mac_config.py',), 02:40:24 INFO - 'default_actions': ('clobber', 02:40:24 INFO - 'read-buildbot-config', 02:40:24 INFO - 'download-and-extract', 02:40:24 INFO - 'populate-webroot', 02:40:24 INFO - 'create-virtualenv', 02:40:24 INFO - 'install', 02:40:24 INFO - 'run-tests'), 02:40:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:40:24 INFO - 'download_minidump_stackwalk': True, 02:40:24 INFO - 'download_symbols': 'ondemand', 02:40:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:40:24 INFO - 'tooltool.py': '/tools/tooltool.py', 02:40:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:40:24 INFO - '/tools/misc-python/virtualenv.py')}, 02:40:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:40:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:40:24 INFO - 'installer_path': 'installer.exe', 02:40:24 INFO - 'log_level': 'info', 02:40:24 INFO - 'log_name': 'talos', 02:40:24 INFO - 'log_to_console': True, 02:40:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:40:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:40:24 INFO - 'opt_config_files': (), 02:40:24 INFO - 'pip_index': False, 02:40:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:40:24 INFO - 'cmd': ('bash', 02:40:24 INFO - '-c', 02:40:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:40:24 INFO - 'enabled': True, 02:40:24 INFO - 'halt_on_failure': False, 02:40:24 INFO - 'name': 'check_screen_resolution'},), 02:40:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:40:24 INFO - 'cmd': ('bash', 02:40:24 INFO - '-c', 02:40:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:40:24 INFO - 'enabled': True, 02:40:24 INFO - 'halt_on_failure': False, 02:40:24 INFO - 'name': 'check_screen_resolution'},), 02:40:24 INFO - 'run_cmd_checks_enabled': True, 02:40:24 INFO - 'sps_profile': False, 02:40:24 INFO - 'sps_profile_interval': 0, 02:40:24 INFO - 'suite': 'dromaeojs-e10s', 02:40:24 INFO - 'system_bits': '32', 02:40:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:40:24 INFO - 'title': 't-yosemite-r7-0141', 02:40:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:40:24 INFO - 'use_talos_json': True, 02:40:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:40:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:40:24 INFO - 'work_dir': 'build'} 02:40:24 INFO - ##### 02:40:24 INFO - ##### Running clobber step. 02:40:24 INFO - ##### 02:40:24 INFO - Running pre-action listener: _resource_record_pre_action 02:40:24 INFO - Running main action method: clobber 02:40:24 INFO - rmtree: /builds/slave/test/build 02:40:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:40:26 INFO - Running post-action listener: _resource_record_post_action 02:40:26 INFO - ##### 02:40:26 INFO - ##### Running read-buildbot-config step. 02:40:26 INFO - ##### 02:40:26 INFO - Running pre-action listener: _resource_record_pre_action 02:40:26 INFO - Running main action method: read_buildbot_config 02:40:26 INFO - Using buildbot properties: 02:40:26 INFO - { 02:40:26 INFO - "project": "", 02:40:26 INFO - "product": "firefox", 02:40:26 INFO - "script_repo_revision": "production", 02:40:26 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 02:40:26 INFO - "repository": "", 02:40:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 02:40:26 INFO - "buildid": "20160622010102", 02:40:26 INFO - "pgo_build": "False", 02:40:26 INFO - "basedir": "/builds/slave/test", 02:40:26 INFO - "buildnumber": 9, 02:40:26 INFO - "slavename": "t-yosemite-r7-0141", 02:40:26 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:40:26 INFO - "platform": "yosemite_r7", 02:40:26 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 02:40:26 INFO - "branch": "mozilla-beta", 02:40:26 INFO - "repo_path": "releases/mozilla-beta", 02:40:26 INFO - "revision": "800dc20aca781026226a03c3f43ff132b5cfdc1d", 02:40:26 INFO - "stage_platform": "macosx64", 02:40:26 INFO - "builduid": "15a2bdba63f94b45ac0a712a9a170911", 02:40:26 INFO - "slavebuilddir": "test" 02:40:26 INFO - } 02:40:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 02:40:26 INFO - Running post-action listener: _resource_record_post_action 02:40:26 INFO - ##### 02:40:26 INFO - ##### Running download-and-extract step. 02:40:26 INFO - ##### 02:40:26 INFO - Running pre-action listener: _resource_record_pre_action 02:40:26 INFO - Running main action method: download_and_extract 02:40:26 INFO - mkdir: /builds/slave/test/build/tests 02:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:26 INFO - https://queue.taskcluster.net/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:40:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 02:40:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 02:40:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/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 02:40:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/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 02:40:28 INFO - Downloaded 1165 bytes. 02:40:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 02:40:28 INFO - Using the following test package requirements: 02:40:28 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 02:40:28 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:40:28 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 02:40:28 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:40:28 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 02:40:28 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 02:40:28 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:40:28 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 02:40:28 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 02:40:28 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:40:28 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 02:40:28 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:40:28 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 02:40:28 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:40:28 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 02:40:28 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:40:28 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 02:40:28 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 02:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:28 INFO - https://queue.taskcluster.net/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:40:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:40:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:40:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/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 02:40:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/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 02:40:29 INFO - Downloaded 18301152 bytes. 02:40:29 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'] 02:40:29 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 02:40:32 INFO - Return code: 0 02:40:32 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 02:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:32 INFO - https://queue.taskcluster.net/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:40:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:40:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:40:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/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 02:40:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/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 02:40:33 INFO - Downloaded 18301152 bytes. 02:40:33 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'] 02:40:33 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 02:40:37 INFO - Return code: 0 02:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:37 INFO - https://queue.taskcluster.net/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:40:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 02:40:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 02:40:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/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 02:40:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/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 02:40:38 INFO - Downloaded 10840145 bytes. 02:40:38 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'] 02:40:38 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 02:40:38 INFO - Return code: 0 02:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:38 INFO - https://queue.taskcluster.net/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 02:40:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:40:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:40:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 02:40:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/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 02:40:42 INFO - Downloaded 86248869 bytes. 02:40:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:40:42 INFO - mkdir: /builds/slave/test/properties 02:40:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:40:42 INFO - Writing to file /builds/slave/test/properties/build_url 02:40:42 INFO - Contents: 02:40:42 INFO - build_url:https://queue.taskcluster.net/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:40:43 INFO - Running post-action listener: _resource_record_post_action 02:40:43 INFO - Running post-action listener: set_extra_try_arguments 02:40:43 INFO - ##### 02:40:43 INFO - ##### Running populate-webroot step. 02:40:43 INFO - ##### 02:40:43 INFO - Running pre-action listener: _resource_record_pre_action 02:40:43 INFO - Running main action method: populate_webroot 02:40:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:40:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:40:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:40:43 INFO - '--tppagecycles', 02:40:43 INFO - '7'], 02:40:43 INFO - 'tests': ['tsvgm']}}, 02:40:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:40:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:40:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:40:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:40:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:40:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:40:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:43 INFO - 'talos_options': ['--disable-e10s'], 02:40:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:40:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:40:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:43 INFO - 'talos_options': ['--disable-e10s'], 02:40:43 INFO - 'tests': ['damp', 'tps']}, 02:40:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:43 INFO - 'tests': ['damp', 'tps']}, 02:40:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:40:43 INFO - 'tests': ['dromaeo_dom']}, 02:40:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:40:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:40:43 INFO - 'tests': ['a11yr', 02:40:43 INFO - 'ts_paint', 02:40:43 INFO - 'tpaint', 02:40:43 INFO - 'sessionrestore', 02:40:43 INFO - 'sessionrestore_no_auto_restore', 02:40:43 INFO - 'tabpaint']}, 02:40:43 INFO - 'other-e10s': {'tests': ['a11yr', 02:40:43 INFO - 'ts_paint', 02:40:43 INFO - 'tpaint', 02:40:43 INFO - 'sessionrestore', 02:40:43 INFO - 'sessionrestore_no_auto_restore', 02:40:43 INFO - 'tabpaint']}, 02:40:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:40:43 INFO - 'ts_paint', 02:40:43 INFO - 'tpaint', 02:40:43 INFO - 'sessionrestore', 02:40:43 INFO - 'sessionrestore_no_auto_restore', 02:40:43 INFO - 'tabpaint']}, 02:40:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:40:43 INFO - 'ts_paint', 02:40:43 INFO - 'tpaint', 02:40:43 INFO - 'sessionrestore', 02:40:43 INFO - 'sessionrestore_no_auto_restore', 02:40:43 INFO - 'tabpaint']}, 02:40:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:40:43 INFO - 'tests': ['a11yr', 02:40:43 INFO - 'ts_paint', 02:40:43 INFO - 'tpaint', 02:40:43 INFO - 'sessionrestore', 02:40:43 INFO - 'sessionrestore_no_auto_restore', 02:40:43 INFO - 'tabpaint']}, 02:40:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:40:43 INFO - 'tests': ['a11yr', 02:40:43 INFO - 'ts_paint', 02:40:43 INFO - 'tpaint', 02:40:43 INFO - 'sessionrestore', 02:40:43 INFO - 'sessionrestore_no_auto_restore', 02:40:43 INFO - 'tabpaint']}, 02:40:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:40:43 INFO - 'tests': ['tsvgx', 02:40:43 INFO - 'tsvgr_opacity', 02:40:43 INFO - 'tart', 02:40:43 INFO - 'tscrollx', 02:40:43 INFO - 'cart']}, 02:40:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:40:43 INFO - 'tsvgr_opacity', 02:40:43 INFO - 'tart', 02:40:43 INFO - 'tscrollx', 02:40:43 INFO - 'cart']}, 02:40:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:43 INFO - 'talos_options': ['--disable-e10s'], 02:40:43 INFO - 'tests': ['tp5o']}, 02:40:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:43 INFO - 'tests': ['tp5o']}, 02:40:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:43 INFO - 'talos_options': ['--disable-e10s', 02:40:43 INFO - '--xperf_path', 02:40:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:40:43 INFO - 'tests': ['tp5n']}, 02:40:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:40:43 INFO - 'talos_options': ['--xperf_path', 02:40:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:40:43 INFO - 'tests': ['tp5n']}}, 02:40:43 INFO - 'talos.zip': {'path': '', 02:40:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:40:43 INFO - Running post-action listener: _resource_record_post_action 02:40:43 INFO - ##### 02:40:43 INFO - ##### Running create-virtualenv step. 02:40:43 INFO - ##### 02:40:43 INFO - Running pre-action listener: _resource_record_pre_action 02:40:43 INFO - Running main action method: create_virtualenv 02:40:43 INFO - Creating virtualenv /builds/slave/test/build/venv 02:40:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:40:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:40:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:40:43 INFO - Using real prefix '/tools/python27' 02:40:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:40:44 INFO - Installing distribute.............................................................................................................................................................................................done. 02:40:46 INFO - Installing pip.................done. 02:40:46 INFO - Return code: 0 02:40:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaeadaa3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a153e00>, '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 0x109fbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a14eb20>, '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.UQUlIApWOb/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.W1eoVFdBHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:40:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:40:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQUlIApWOb/Render', 02:40:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:40:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:40:46 INFO - 'HOME': '/Users/cltbld', 02:40:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:40:46 INFO - 'LOGNAME': 'cltbld', 02:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:46 INFO - 'MOZ_NO_REMOTE': '1', 02:40:46 INFO - 'NO_EM_RESTART': '1', 02:40:46 INFO - 'PAGER': '/bin/cat', 02:40:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:46 INFO - 'PWD': '/builds/slave/test', 02:40:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:40:46 INFO - 'SHELL': '/bin/bash', 02:40:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eoVFdBHR/Listeners', 02:40:46 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 02:40:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:40:46 INFO - 'USER': 'cltbld', 02:40:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:40:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:46 INFO - 'XPC_FLAGS': '0x0', 02:40:46 INFO - 'XPC_SERVICE_NAME': '0', 02:40:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:40:47 INFO - Cleaning up... 02:40:47 INFO - Return code: 0 02:40:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:47 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 0x10a2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaeadaa3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a153e00>, '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 0x109fbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a14eb20>, '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.UQUlIApWOb/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.W1eoVFdBHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:40:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQUlIApWOb/Render', 02:40:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:40:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:40:47 INFO - 'HOME': '/Users/cltbld', 02:40:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:40:47 INFO - 'LOGNAME': 'cltbld', 02:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:47 INFO - 'MOZ_NO_REMOTE': '1', 02:40:47 INFO - 'NO_EM_RESTART': '1', 02:40:47 INFO - 'PAGER': '/bin/cat', 02:40:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:47 INFO - 'PWD': '/builds/slave/test', 02:40:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:40:47 INFO - 'SHELL': '/bin/bash', 02:40:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eoVFdBHR/Listeners', 02:40:47 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 02:40:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:40:47 INFO - 'USER': 'cltbld', 02:40:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:40:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:47 INFO - 'XPC_FLAGS': '0x0', 02:40:47 INFO - 'XPC_SERVICE_NAME': '0', 02:40:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:47 INFO - Downloading/unpacking psutil>=0.7.1 02:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:40:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:40:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:40:50 INFO - Installing collected packages: psutil 02:40:50 INFO - Running setup.py install for psutil 02:40:50 INFO - building 'psutil._psutil_osx' extension 02:40:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:40:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:40:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:40:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:40:51 INFO - building 'psutil._psutil_posix' extension 02:40:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:40:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:40:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:40:51 INFO - ^ 02:40:51 INFO - 1 warning generated. 02:40:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:40:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:40:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:40:51 INFO - Successfully installed psutil 02:40:51 INFO - Cleaning up... 02:40:51 INFO - Return code: 0 02:40:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:40: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')]} 02:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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')]} 02:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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', '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 0x10a2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaeadaa3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a153e00>, '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 0x109fbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a14eb20>, '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.UQUlIApWOb/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.W1eoVFdBHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:40: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:40: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 mozsystemmonitor==0.0.0 02:40:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQUlIApWOb/Render', 02:40:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:40:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:40:51 INFO - 'HOME': '/Users/cltbld', 02:40:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:40:51 INFO - 'LOGNAME': 'cltbld', 02:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:51 INFO - 'MOZ_NO_REMOTE': '1', 02:40:51 INFO - 'NO_EM_RESTART': '1', 02:40:51 INFO - 'PAGER': '/bin/cat', 02:40:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:51 INFO - 'PWD': '/builds/slave/test', 02:40:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:40:51 INFO - 'SHELL': '/bin/bash', 02:40:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eoVFdBHR/Listeners', 02:40:51 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 02:40:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:40:51 INFO - 'USER': 'cltbld', 02:40:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:40:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:51 INFO - 'XPC_FLAGS': '0x0', 02:40:51 INFO - 'XPC_SERVICE_NAME': '0', 02:40:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:40: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 02:40: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 02:40: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 02:40: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 02:40: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 02:40: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 02:40:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:40:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:40:54 INFO - Installing collected packages: mozsystemmonitor 02:40:54 INFO - Running setup.py install for mozsystemmonitor 02:40:54 INFO - Successfully installed mozsystemmonitor 02:40:54 INFO - Cleaning up... 02:40:54 INFO - Return code: 0 02:40:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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', '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 0x10a2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaeadaa3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a153e00>, '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 0x109fbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a14eb20>, '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.UQUlIApWOb/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.W1eoVFdBHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:40: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:40: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 blobuploader==1.2.4 02:40:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQUlIApWOb/Render', 02:40:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:40:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:40:54 INFO - 'HOME': '/Users/cltbld', 02:40:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:40:54 INFO - 'LOGNAME': 'cltbld', 02:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:54 INFO - 'MOZ_NO_REMOTE': '1', 02:40:54 INFO - 'NO_EM_RESTART': '1', 02:40:54 INFO - 'PAGER': '/bin/cat', 02:40:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:54 INFO - 'PWD': '/builds/slave/test', 02:40:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:40:54 INFO - 'SHELL': '/bin/bash', 02:40:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eoVFdBHR/Listeners', 02:40:54 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 02:40:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:40:54 INFO - 'USER': 'cltbld', 02:40:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:40:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:54 INFO - 'XPC_FLAGS': '0x0', 02:40:54 INFO - 'XPC_SERVICE_NAME': '0', 02:40:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:54 INFO - Downloading/unpacking blobuploader==1.2.4 02:40: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 02:40: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 02:40: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 02:40: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 02:40: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 02:40: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 02:40:57 INFO - Downloading blobuploader-1.2.4.tar.gz 02:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:40:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:40: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 02:40: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 02:40: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 02:40: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 02:40: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 02:40: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 02:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:40:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:40: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 02:40: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 02:40: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 02:40: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 02:40: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 02:40: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 02:40:58 INFO - Downloading docopt-0.6.1.tar.gz 02:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:40:58 INFO - Installing collected packages: blobuploader, requests, docopt 02:40:58 INFO - Running setup.py install for blobuploader 02:40:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:40:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:40:58 INFO - Running setup.py install for requests 02:40:59 INFO - Running setup.py install for docopt 02:40:59 INFO - Successfully installed blobuploader requests docopt 02:40:59 INFO - Cleaning up... 02:40:59 INFO - Return code: 0 02:40:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:59 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 0x10a2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaeadaa3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a153e00>, '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 0x109fbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a14eb20>, '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.UQUlIApWOb/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.W1eoVFdBHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:40:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQUlIApWOb/Render', 02:40:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:40:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:40:59 INFO - 'HOME': '/Users/cltbld', 02:40:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:40:59 INFO - 'LOGNAME': 'cltbld', 02:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:59 INFO - 'MOZ_NO_REMOTE': '1', 02:40:59 INFO - 'NO_EM_RESTART': '1', 02:40:59 INFO - 'PAGER': '/bin/cat', 02:40:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:59 INFO - 'PWD': '/builds/slave/test', 02:40:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:40:59 INFO - 'SHELL': '/bin/bash', 02:40:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eoVFdBHR/Listeners', 02:40:59 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 02:40:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:40:59 INFO - 'USER': 'cltbld', 02:40:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:40:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:59 INFO - 'XPC_FLAGS': '0x0', 02:40:59 INFO - 'XPC_SERVICE_NAME': '0', 02:40:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:40:59 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-SmLXwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:40:59 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-1qKQ60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:41:00 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-rGBnh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:41:00 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-VgNvPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:41:00 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Yjgc1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:41:00 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-WZt0fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:41:00 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-EE4r0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:41:00 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-bgfage-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:41:00 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-exoi5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:41:00 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-ikWuJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:41:00 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-nSwDoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:41:00 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-7UVs6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:41:01 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-JDUzSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:41:01 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-uKxJky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:01 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-w9Tme0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:41:01 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-EtYZ6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:41:01 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-_q9acC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:41:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:41:01 INFO - Running setup.py install for manifestparser 02:41:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:41:01 INFO - Running setup.py install for mozcrash 02:41:01 INFO - Running setup.py install for mozdebug 02:41:02 INFO - Running setup.py install for mozdevice 02:41:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:41:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:41:02 INFO - Running setup.py install for mozfile 02:41:02 INFO - Running setup.py install for mozhttpd 02:41:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:41:02 INFO - Running setup.py install for mozinfo 02:41:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:41:02 INFO - Running setup.py install for mozInstall 02:41:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:41:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:41:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:41:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:41:02 INFO - Running setup.py install for mozleak 02:41:02 INFO - Running setup.py install for mozlog 02:41:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:41:03 INFO - Running setup.py install for moznetwork 02:41:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:41:03 INFO - Running setup.py install for mozprocess 02:41:03 INFO - Running setup.py install for mozprofile 02:41:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:41:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:41:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:41:03 INFO - Running setup.py install for mozrunner 02:41:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:41:03 INFO - Running setup.py install for mozscreenshot 02:41:03 INFO - Running setup.py install for moztest 02:41:04 INFO - Running setup.py install for mozversion 02:41:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:41:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:41:04 INFO - Cleaning up... 02:41:04 INFO - Return code: 0 02:41:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:04 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 0x10a2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaeadaa3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a153e00>, '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 0x109fbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a14eb20>, '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.UQUlIApWOb/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.W1eoVFdBHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:41:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQUlIApWOb/Render', 02:41:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:04 INFO - 'HOME': '/Users/cltbld', 02:41:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:04 INFO - 'LOGNAME': 'cltbld', 02:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:04 INFO - 'MOZ_NO_REMOTE': '1', 02:41:04 INFO - 'NO_EM_RESTART': '1', 02:41:04 INFO - 'PAGER': '/bin/cat', 02:41:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:04 INFO - 'PWD': '/builds/slave/test', 02:41:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:04 INFO - 'SHELL': '/bin/bash', 02:41:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eoVFdBHR/Listeners', 02:41:04 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 02:41:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:04 INFO - 'USER': 'cltbld', 02:41:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:04 INFO - 'XPC_FLAGS': '0x0', 02:41:04 INFO - 'XPC_SERVICE_NAME': '0', 02:41:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:41:04 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-OqP6SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:41:04 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-CNG9bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:41:04 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-zGmtzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:41:04 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-CFUpSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:41:04 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-vqYqBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:41:05 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-nF4S4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:41:05 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-lB2dtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:41:05 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-LSQNHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:41:05 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-JJmRRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:41:05 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-_7ksL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:41:05 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-gKpSyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:41:05 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-dV5oKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:41:05 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-hCoOCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:41:05 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-wFGAZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:05 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-h5voe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:41:06 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-GWxb_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:41:06 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-xN1mpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:41:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:08 INFO - Downloading blessings-1.6.tar.gz 02:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:41:08 INFO - Installing collected packages: blessings 02:41:08 INFO - Running setup.py install for blessings 02:41:09 INFO - Successfully installed blessings 02:41:09 INFO - Cleaning up... 02:41:09 INFO - Return code: 0 02:41:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:41:09 INFO - Reading from file tmpfile_stdout 02:41:09 INFO - Current package versions: 02:41:09 INFO - blessings == 1.6 02:41:09 INFO - blobuploader == 1.2.4 02:41:09 INFO - docopt == 0.6.1 02:41:09 INFO - manifestparser == 1.1 02:41:09 INFO - mozInstall == 1.12 02:41:09 INFO - mozcrash == 0.17 02:41:09 INFO - mozdebug == 0.1 02:41:09 INFO - mozdevice == 0.48 02:41:09 INFO - mozfile == 1.2 02:41:09 INFO - mozhttpd == 0.7 02:41:09 INFO - mozinfo == 0.9 02:41:09 INFO - mozleak == 0.1 02:41:09 INFO - mozlog == 3.1 02:41:09 INFO - moznetwork == 0.27 02:41:09 INFO - mozprocess == 0.22 02:41:09 INFO - mozprofile == 0.28 02:41:09 INFO - mozrunner == 6.11 02:41:09 INFO - mozscreenshot == 0.1 02:41:09 INFO - mozsystemmonitor == 0.0 02:41:09 INFO - moztest == 0.7 02:41:09 INFO - mozversion == 1.4 02:41:09 INFO - psutil == 3.1.1 02:41:09 INFO - requests == 1.2.3 02:41:09 INFO - wsgiref == 0.1.2 02:41:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:09 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 0x10a2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaeadaa3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a153e00>, '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 0x109fbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a14eb20>, '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.UQUlIApWOb/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.W1eoVFdBHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:41:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQUlIApWOb/Render', 02:41:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:09 INFO - 'HOME': '/Users/cltbld', 02:41:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:09 INFO - 'LOGNAME': 'cltbld', 02:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:09 INFO - 'MOZ_NO_REMOTE': '1', 02:41:09 INFO - 'NO_EM_RESTART': '1', 02:41:09 INFO - 'PAGER': '/bin/cat', 02:41:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:09 INFO - 'PWD': '/builds/slave/test', 02:41:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:09 INFO - 'SHELL': '/bin/bash', 02:41:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eoVFdBHR/Listeners', 02:41:09 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 02:41:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:09 INFO - 'USER': 'cltbld', 02:41:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:09 INFO - 'XPC_FLAGS': '0x0', 02:41:09 INFO - 'XPC_SERVICE_NAME': '0', 02:41:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:41:09 INFO - Cleaning up... 02:41:09 INFO - Return code: 0 02:41:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:09 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 0x10a2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaeadaa3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a153e00>, '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 0x109fbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a14eb20>, '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.UQUlIApWOb/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.W1eoVFdBHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:41:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQUlIApWOb/Render', 02:41:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:09 INFO - 'HOME': '/Users/cltbld', 02:41:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:09 INFO - 'LOGNAME': 'cltbld', 02:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:09 INFO - 'MOZ_NO_REMOTE': '1', 02:41:09 INFO - 'NO_EM_RESTART': '1', 02:41:09 INFO - 'PAGER': '/bin/cat', 02:41:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:09 INFO - 'PWD': '/builds/slave/test', 02:41:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:09 INFO - 'SHELL': '/bin/bash', 02:41:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eoVFdBHR/Listeners', 02:41:09 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 02:41:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:09 INFO - 'USER': 'cltbld', 02:41:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:09 INFO - 'XPC_FLAGS': '0x0', 02:41:09 INFO - 'XPC_SERVICE_NAME': '0', 02:41:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:09 INFO - Downloading/unpacking jsonschema 02:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:41:12 INFO - Downloading/unpacking functools32 (from jsonschema) 02:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:12 INFO - Downloading functools32-3.2.3-2.tar.gz 02:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:41:12 INFO - warning: no files found matching '*.txt' 02:41:12 INFO - no previously-included directories found matching 'build' 02:41:12 INFO - no previously-included directories found matching 'dist' 02:41:12 INFO - no previously-included directories found matching '.git*' 02:41:12 INFO - Installing collected packages: jsonschema, functools32 02:41:12 INFO - Running setup.py install for functools32 02:41:13 INFO - warning: no files found matching '*.txt' 02:41:13 INFO - no previously-included directories found matching 'build' 02:41:13 INFO - no previously-included directories found matching 'dist' 02:41:13 INFO - no previously-included directories found matching '.git*' 02:41:13 INFO - Successfully installed jsonschema functools32 02:41:13 INFO - Cleaning up... 02:41:13 INFO - Return code: 0 02:41:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:13 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 0x10a2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaeadaa3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a153e00>, '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 0x109fbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a14eb20>, '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.UQUlIApWOb/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.W1eoVFdBHR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:41:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:41:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQUlIApWOb/Render', 02:41:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:13 INFO - 'HOME': '/Users/cltbld', 02:41:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:13 INFO - 'LOGNAME': 'cltbld', 02:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:13 INFO - 'MOZ_NO_REMOTE': '1', 02:41:13 INFO - 'NO_EM_RESTART': '1', 02:41:13 INFO - 'PAGER': '/bin/cat', 02:41:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:13 INFO - 'PWD': '/builds/slave/test', 02:41:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:13 INFO - 'SHELL': '/bin/bash', 02:41:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eoVFdBHR/Listeners', 02:41:13 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 02:41:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:13 INFO - 'USER': 'cltbld', 02:41:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:13 INFO - 'XPC_FLAGS': '0x0', 02:41:13 INFO - 'XPC_SERVICE_NAME': '0', 02:41:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:13 INFO - Downloading/unpacking flake8 02:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:41:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:41:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:41:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:41:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:41:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:41:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:41:17 INFO - no previously-included directories found matching 'docs/_build' 02:41:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:41:17 INFO - Running setup.py install for pep8 02:41:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:41:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:41:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:41:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:41:17 INFO - no previously-included directories found matching 'docs/_build' 02:41:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:41:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:41:17 INFO - Cleaning up... 02:41:17 INFO - Return code: 0 02:41:17 INFO - Running post-action listener: _resource_record_post_action 02:41:17 INFO - Running post-action listener: _start_resource_monitoring 02:41:17 INFO - Starting resource monitoring. 02:41:17 INFO - ##### 02:41:17 INFO - ##### Running install step. 02:41:17 INFO - ##### 02:41:17 INFO - Running pre-action listener: _resource_record_pre_action 02:41:17 INFO - Running main action method: install 02:41:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:41:18 INFO - Reading from file tmpfile_stdout 02:41:18 INFO - Detecting whether we're running mozinstall >=1.0... 02:41:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:41:18 INFO - Reading from file tmpfile_stdout 02:41:18 INFO - Output received: 02:41:18 INFO - Usage: mozinstall [options] installer 02:41:18 INFO - Options: 02:41:18 INFO - -h, --help show this help message and exit 02:41:18 INFO - -d DEST, --destination=DEST 02:41:18 INFO - Directory to install application into. [default: 02:41:18 INFO - "/builds/slave/test"] 02:41:18 INFO - --app=APP Application being installed. [default: firefox] 02:41:18 INFO - mkdir: /builds/slave/test/build/application 02:41:18 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'] 02:41:18 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 02:41:40 INFO - Reading from file tmpfile_stdout 02:41:40 INFO - Output received: 02:41:40 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 02:41:40 INFO - Running post-action listener: _resource_record_post_action 02:41:40 INFO - ##### 02:41:40 INFO - ##### Running run-tests step. 02:41:40 INFO - ##### 02:41:40 INFO - Running pre-action listener: _resource_record_pre_action 02:41:40 INFO - Running main action method: run_tests 02:41:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:41:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:41:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:41:40 INFO - 2016-06-22 02:41:40.519 screenresolution[1639:7452] starting screenresolution argv=screenresolution get 02:41:40 INFO - 2016-06-22 02:41:40.522 screenresolution[1639:7452] Display 0: 1600x1200x32@60 02:41:40 INFO - 2016-06-22 02:41:40.528 screenresolution[1640:7454] starting screenresolution argv=screenresolution list 02:41:40 INFO - Available Modes on Display 0 02:41:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:41:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:41:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:41:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:41:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:41:40 INFO - Intel Iris: 02:41:40 INFO - Chipset Model: Intel Iris 02:41:40 INFO - Type: GPU 02:41:40 INFO - Bus: Built-In 02:41:40 INFO - VRAM (Dynamic, Max): 1536 MB 02:41:40 INFO - Vendor: Intel (0x8086) 02:41:40 INFO - Device ID: 0x0a2e 02:41:40 INFO - Revision ID: 0x0009 02:41:40 INFO - Displays: 02:41:40 INFO - Display: 02:41:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:41:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:41:40 INFO - Display Serial Number: 1600x1200 60 02:41:40 INFO - Main Display: Yes 02:41:40 INFO - Mirror: Off 02:41:40 INFO - Online: Yes 02:41:40 INFO - Rotation: Supported 02:41:40 INFO - Return code: 0 02:41:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:41:40 INFO - Python 2.7.3 02:41:40 INFO - Return code: 0 02:41:40 INFO - grabbing minidump binary from tooltool 02:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:40 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a153e00>, '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 0x109fbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a14eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:41:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:41:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:41:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:41:40 INFO - Return code: 0 02:41:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:41:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:41:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:41:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:41:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:41:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:41:41 INFO - Return code: 0 02:41:41 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/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0141', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:41:41 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/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0141 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:41:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQUlIApWOb/Render', 02:41:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:41 INFO - 'HOME': '/Users/cltbld', 02:41:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:41 INFO - 'LOGNAME': 'cltbld', 02:41:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:41:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:41 INFO - 'MOZ_NO_REMOTE': '1', 02:41:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:41:41 INFO - 'NO_EM_RESTART': '1', 02:41:41 INFO - 'PAGER': '/bin/cat', 02:41:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:41 INFO - 'PWD': '/builds/slave/test', 02:41:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:41:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:41 INFO - 'SHELL': '/bin/bash', 02:41:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eoVFdBHR/Listeners', 02:41:41 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 02:41:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:41 INFO - 'USER': 'cltbld', 02:41:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:41 INFO - 'XPC_FLAGS': '0x0', 02:41:41 INFO - 'XPC_SERVICE_NAME': '0', 02:41:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:41:41 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/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0141', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:41:42 INFO - mozversion application_buildid: 20160622010102 02:41:42 INFO - mozversion application_changeset: 800dc20aca781026226a03c3f43ff132b5cfdc1d 02:41:42 INFO - mozversion application_display_name: Firefox 02:41:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:41:42 INFO - mozversion application_name: Firefox 02:41:42 INFO - mozversion application_remotingname: firefox 02:41:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:41:42 INFO - mozversion application_vendor: Mozilla 02:41:42 INFO - mozversion application_version: 48.0 02:41:42 INFO - mozversion platform_buildid: 20160622010102 02:41:42 INFO - mozversion platform_changeset: 800dc20aca781026226a03c3f43ff132b5cfdc1d 02:41:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:41:42 INFO - mozversion platform_version: 48.0 02:41:42 INFO - using testdate: 1466588502 02:41:42 INFO - actual date: 1466588502 02:41:42 INFO - starting webserver on 'localhost:49276' 02:41:42 INFO - SUITE-START | Running 2 tests 02:41:42 INFO - TEST-START | dromaeo_css 02:41:42 INFO - operating with platform_type : mac_ 02:41:42 INFO - Initialising browser for dromaeo_css test... 02:41:42 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpgew8zu/profile http://localhost:49276/getInfo.html) 02:41:44 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 02:41:44 INFO - PROCESS | 1658 | colorDepth:24 02:41:44 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 02:41:44 INFO - PROCESS | 1658 | __metrics 02:41:45 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 02:41:45 INFO - TEST-INFO | 1658: exit 0 02:41:45 INFO - Browser initialized. 02:41:45 INFO - Running cycle 1/1 for dromaeo_css test... 02:41:45 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpgew8zu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:41:57 INFO - PROCESS | 1662 | RSS: Main: 171139072 02:41:57 INFO - PROCESS | 1662 | 02:42:47 INFO - PROCESS | 1662 | 1466588567053 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:44:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 02:44:58 INFO - PROCESS | 1662 | RSS: Main: 181936128 02:44:58 INFO - PROCESS | 1662 | 02:48:00 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 02:48:01 INFO - PROCESS | 1662 | RSS: Main: 192557056 02:48:01 INFO - PROCESS | 1662 | 02:51:03 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 02:51:03 INFO - PROCESS | 1662 | RSS: Main: 194703360 02:51:03 INFO - PROCESS | 1662 | 02:54:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 02:54:05 INFO - PROCESS | 1662 | RSS: Main: 198410240 02:54:05 INFO - PROCESS | 1662 | 02:57:08 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 02:57:09 INFO - PROCESS | 1662 | RSS: Main: 197394432 02:57:09 INFO - PROCESS | 1662 | 03:00:11 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 03:00:11 INFO - PROCESS | 1662 | RSS: Main: 202694656 03:00:11 INFO - PROCESS | 1662 | 03:00:11 INFO - PROCESS | 1662 | __start_tp_report 03:00:11 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 03:00:11 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 03:00:11 INFO - PROCESS | 1662 | |i|pagename|runs| 03:00:11 INFO - PROCESS | 1662 | |0;dojo.html;3640.526731524901;3682.594914559398;3708.221273532558;3729.5524537055558;3739.214764899371;4476.731396116235;5842.123681447785;5878.823635290937;6001.489873360764;6044.758209671608;6010.849728756783;6018.458338749511;6025.548083893704;6056.970315046442;6059.151718759377;5328.0675881720645;5368.463153684639;5403.432639572828;5421.024215641183;5553.500184983351;5352.678839269656;5416.4312747161575;5533.335999680024;5589.357223919261;5602.271704678386;5395.7032363220005;5442.6462279951675;5468.589855760814;5468.890622187554;5503.559715222793;4212.7682977436225;5455.754491047893;5471.5896307776675;5473.452654734535;5517.641353312022;5206.323177986876;5287.259783630257;5305.124654432014;5336.573074154097;5409.648372855751;4625.930611040837;5839.8540036499;5906.173135760997;5913.172155898178;5992.400759924017;6265.8120256392385;6341.8414539636415;6360.681965901686;6373.713182906734;6379.776707815204;6275.717592708339;6356.77751278703;6356.904646430307;6382.329855365213;6459.386358295955;5025.472325405816;6111.602745821508;6118.663473508956;6139.723712432951;6140.048292514667;6538.1827271591055;6547.410733033955;6547.574407663486;6570.770023049266;6575.243846957661;6161.260648722182;6166.81499555014;6229.2524897012645;6276.560640755103;6277.591956522811;6373.235211774524;6378.425941665272;6431.678416079271;6432.485401167895;6467.320931302145;6313.305536390993;6331;6332.715027823759;6352.650604216812;6354.745810167634;6191.566590338633;6280.560360774702;6329.303776584572;6329.367063293634;6338.461230795342;5069.569086627678;5115.053715062725;5115.0792857285305;5124.897502050013;5125.15434953236;4565.840195593139;4598.195315819785;4606.124836281163;4646.558576935186;4647.674662773574;4989.700617962933;6058.545609079337;6109.327973922865;6117.143599896018;6159.353267906895;6398.872022559616;6429.710663020175;6447.548671593037;6453.967730161413;6463.418292353711;6046.425589568984;6150.169727086786;6153.353897840662;6160.199174107337;6167.259928808572;4819.59033482151;5574.944250557523;5644.266245388156;5666.2350582670815;5722.427757224327;5229.790808367698;6660.333966603398;6666.799996000128;6669.46644268467;6678.298778628271;6311.400416960381;6381.680915954276;6395.488360931021;6446.67766611677;6464.903026454701;6618.966905165444;6653.035309880137;6664.366885145903;6664.4668426524795;6674.966625166843;6307.779227727007;6321.905171422341;6324.367563243639;6329.050642403677;6372.394622510854;5792.044312688359;6225.097360882737;6293.685315734287;6437.195350581177;6442.967785161231;5437.238786569963;6249;6252.781152659635;6279.246490421178;6282.1519094921605;6194.566380353332;6229.4393504584805;6246.656433895998;6262.248530176408;6275.184226050585;5693.174489699053;5886.646801191942;6017.729202185825;6110.923300256584;6152.507799376129;6228.968855155696;6259.593126446766;6285.465735412358;6287.1512345832725;6291.622502649856;6196.380361963767;6234;6239.812805615838;6240.4071613196675;6301.149344838388 03:00:11 INFO - PROCESS | 1662 | |1;ext.html;535.1785010009635;545.3973359437821;574.4743559642927;576.708762075152;626.4988009592328;39842.80078599606;40745.98135046625;40807.59192408075;40843.79578102113;41005.97485062875;41262.58737412625;41416.378754318706;42069.57930420695;42331.3650295245;43061;9655.662051828187;9821.459819709913;9833.65582204623;9859.507024648774;9875.209983201363;9830.705078847646;9881.35771174875;9953.502324883726;9960.750981225456;9979.950100249489;9920.255980801432;10003.449810260432;10015.998400159962;10042.949785251063;10047.598096076148;8776.078511756301;9582.233421326277;9922.950385248063;9955.90044099557;10000.149987251092;9652;9733.805323893483;9790.167835733972;9812.165965892907;9828.901710982871;39140.804295978334;39171;39365.40951885724;39401;39924.00189995244;3020.7432368248506;3274.9017529473917;3298.2084299767885;3406.8807591734417;3473.930521389558;29548.556771648444;29611.703882961327;29826.85086574553;30632.693673063208;31526.842365788023;2775.639166908289;2787.6097346371525;2817.29567608098;2851.0591504803365;2857.5126696336933;426087;426680;432451.83774081245;432975;434936;66131.33868661252;66225.66887165533;66595;66621.66689166523;66636;68089;70562.2943770566;70619;72206.63896680484;73676;18134.5466363342;18779.24883004692;18871.716924246146;19024.619507609772;19096.71354929677;14082;14475.203863787592;14501.912356573299;14522.49171279;14526.927365363317;20551.79448205499;20836.47908802292;20925.476863078544;20943.581128377347;20950.47623809417;7812;7841.843163136706;8587;8759.255463285692;8840.469571825712;955.9866541466068;1038.1746511523356;1040.2250323508883;1057.582255009267;1138.6014894786758;24467.38831529226;26156.607650885253;30243;31082.378352433276;31739.52390714141;1102.5093833244289;1126.830975353687;1139.2196345503357;1160.8606967163994;1179.8820117988305;13352.998525110655;14380.85619143816;14853;14905.776413353808;15143.561361670623;508149.4592527014;621799;622856;643251;646331.7683411647;59607;61599.692001539705;61728.382716172266;61799;62070.379296207364;1363.5704753002772;1563.3121426572272;1572.3867691600515;1574.3073047859134;1598.5524053265103;29284.414311714074;29345;29505.557416639196;29636.703632963396;30067;53157.734211328694;53354.19968700395;54191;54251.45748542464;54530;557819;572593;576182;578031.3295300658;578536;26699.19902402931;26828.59757103684;27569.862150689118;27737.44525109446;28072.85963570251;45257.32114018226;45820.77089614664;46154.53845461502;47019.82450438767;47112.52887471081;37444;38224.808875955445;38240.61759382371;38394.616053839105;38838.6116138835;37182.25635487221;37790.811045945695;37903.05242368963;38020.80989595034;38247.61752382552;36156.81921590375;37900.43149352817;38935;39049.60950390573;39084.41373379459;31844.5223321655;33129.50305745464;33302;33663;33814.3237135251;24962.375940600905;25339.87330063338;25378.619320709833;25670.61494077628;25758.383709514157 03:00:11 INFO - PROCESS | 1662 | |2;jquery.html;411.500027466628;415.40389541008653;416.704140060557;418.0364260379827;423.43471465593433;20509.589808203844;21200.045997930112;21221.257255996043;21472.570548589018;22530.549389012253;12068.879311206907;12189.573364932228;12500;12502;12514.24914505128;5339.119045357511;5438.809641662542;5482.698451585181;5536.446355364452;5584.972075139639;5404.378496472897;5530.142827861688;5825.126231065353;6105.481034112106;6125.356837532062;5899.380565040673;5978.611390259641;6113.847153821168;6114.052321890092;6959.826004349881;6822.215445223788;6842.965785171092;6858.691358888862;6899.931000690004;6919.757808476729;5598.1602759585985;5746.655200687972;5935.614185077956;6124.387561243884;6174.197354343952;14244.715105697827;14411.991160618762;14438.855611443856;23946;26546.203613891616;2147.5060736030646;2214.1586197245106;2235.441139715071;2339.0994467130276;2365.9171928982573;9219.35464517484;10383.42891140987;10471.214658900537;10472.633457828939;10473.057424831726;1802.5763945472804;1813.555678858688;1828.2686925229882;1929.045122664276;1936.845052395805;106828;108070;109367.90632093657;110490.6322076704;111703;12067;12204.572839950559;12220.694482637828;12223;12233;15682;15812.92093539525;15870.047797132209;15880.60298492547;15933.68132637364;9431.90568094324;9438.38650487716;9557.139857412867;9626.422414655002;9672.95163524192;8162.14297498766;9235.307351948632;9536.809263814685;9582.760430989281;9610.327277090537;4793.472718001017;4804.81380971657;4816.975915120472;4861.854144375674;4917.28699338601;2031.837453003756;2115.375964090597;2142.828573714099;2176.6734989751662;2178.2267295110323;911.9544022798833;966.21253678252;983.7983213441228;1058;1075.5590208014676;19980.10089545974;20677.689834652494;20948.790512094987;21138.365849024554;21168.470788230417;987.8567607696843;1027.8715160604925;1028.5371582787775;1036.6682661548382;1072.978540429187;9463.064824188175;10353.482325883675;11212.607558735404;12076.879231207751;12152.270863748203;648535;654817;657178;657313;663956;104618;127194;142636.5736342644;142998;144933;1046.5186014433293;1050.3277902142636;1061.984070238947;1078.741102135482;1082.420904815904;18383.17275722569;18472.81527184765;18581;18640.81359186445;18686.53283667865;52877.47122528879;53841;53980.73009634927;54715.45284547104;55293;78228;79673;83524;84160.57919710607;84379.3124137526;7387.630618468947;8283.420160588701;8405.621747021276;8429.662813487637;8442.620082096197;12320.938395307967;12812.423440945366;12860.292683902475;12957.546485872948;13062.608121756362;11183.161262905152;11322;11341.886581134084;11497.942510287396;11498.94250528742;9738.123568878835;11129.499172537417;11173.608923687632;11375.43122843838;11379;11425.542978280775;11597.76804463923;11736;11773.99921006724;11815.40922953866;8430.45202061864;8475.32197424217;8490.745277641681;8526.658933642833;8624.310055195694;10918.290311129751;11405.828912566152;11408.258463199865;11434.828477572677;11613.070954323803 03:00:11 INFO - PROCESS | 1662 | |3;mootools.html;1626.1381467822055;1637.959051023724;1949.1326359769907;2026.624871041981;2087.6451003329435;8127.9593602032055;8740.125987401258;8874.77813054674;9102.590383432736;9131.497767622786;8811.559422028906;8837.293016558677;8944.686935957243;8947.955260223689;8960.596773145207;2143.678448232762;2181.4873504726374;2435.890384932682;2516.069054449847;2530.7595778401023;2561.70540387855;2571.7299683533242;2587.32729490332;2600.0119954417296;2633.8814753336146;2540.6697129373156;2544.7709706126443;2566.5251928393213;2571.7428257174224;2579.0586435950836;2562.654041704374;2578.6003169508663;2586.922392328233;2598.4803039392195;2599.558075127214;2180.803727664502;2335.346103091137;2570.5373032854077;2622.960655590168;2630.907918222872;8979.68571100015;9094;9129.908700912973;9174.495402752913;9176.082391760838;5601.187827764992;5664.830055098312;5698.202251684767;5802.12968054791;5812.505936995361;3604.189057462076;3670.724695647837;3680.245549662313;3747.2880152770886;3760.3607386744047;1033.3438266700623;1040.110705346925;1042.0985847242157;1042.8435734639788;1050.033968748753;11829.99445047172;11884.940575297154;12162.51349946001;12366.258024518558;12399.318037507934;4963.131451995886;5019.498050194951;5118.692878427306;5179.663321884065;5222.55608273301;10316.071553560065;10346.948265258625;10555.26113172086;10673.626423075155;10717.410542420243;4876;5753.165790960371;5779;5797.507211886952;5801.767929282866;4374.825006999748;4578.496365399803;5000;5000.89998200034;5161.74191290434;3559.394902866467;4279.315309550457;4299.1831552005015;4388.4733831940375;4389.517153113155;1403.943842246319;1439.8992070554962;1442.5960730995128;1443.3216388297483;1452.0924422236103;832.937529685276;910.5219759626249;919.7537336908526;960.8798900137483;973.4986481961795;4595.598342505501;5298.81454149103;5890.705464726747;6125.540584456184;6154.661493617894;839.3704721458906;947.924166066713;949.3971328206501;971.5676523946776;996.3623281100101;4064.837406503766;4115.218108559364;4146.606072423115;4178.791060446965;4180.540140584533;10705.357678539312;10999;11033.337999720043;11078.446077696082;11190.216684832147;10724.249302548902;10730.409827459565;10869.347839129678;10927.453627318602;11002.889971100347;8370.204830541088;8449.45078569891;8479.236868681724;8508.659653613786;8598.699045533376;5394.379646340721;5931.9110213345975;6000.459958603747;6114.602550834359;6242.781502647385;9252.028537003787;9277.350585459222;9296.442213467213;9333;9490.288228383037;8093.473924194908;9640.807183856425;9688.75778105553;9767.023297670461;9804.85292720624;7378.409727221702;7676.193999630182;7694.769156925301;7708.4218683600075;7814.804629884298;7414;8328.08391076969;8332.333413326798;8363.707270245512;8487.915120848713;7403.296686814744;7551.886721699069;7607.16321204656;7665.961670191613;7669.61651917413;6150.415710507495;7398.889016664862;7444.069491313586;7453.366463850633;7538.434617403607;7065;7101.857962840818;7164.820879478055;7194.748183813542;7222.819429514094;4972.8756781080765;4977.129002424634;5057.873553161053;5090.312807770903;5093.592512598909;4700.670953033392;4955.231939049453;5031.094403007493;5157.406898206755;5220.556252718561 03:00:11 INFO - PROCESS | 1662 | |4;prototype.html;336.396168876866;337.97087867443634;339.22825571824103;344.70734744707346;347.18584918366423;6440.259370172432;6781.76263830766;6937.757178498754;6981.511294209401;6986.510944233905;6932.376086152245;6979.092717946673;6992.160940687112;7013.649317534128;7021.89467157993;5154.819581314655;5181.145111056671;5185.533302002819;5189.325387699603;5200.713960732158;5104.744762761866;5200.843974680765;5200.895982080356;5212.0097181535575;5221.269022336875;5154;5164.922526162091;5172.146595811687;5179.326687530615;5184;4855.344528488662;5024.748762561857;5036.722980236085;5163.612729045318;5166.199239117943;4260.573942605714;4266.679999000087;4268.55180206077;4274.465691788527;4293.828246870122;6642.833929151761;6648.135742353463;6654.6672666366485;6689.698963546603;6693.196816382066;5942.910856337158;5956.434138756811;5965.403459654;5966.224390829208;5967.850803729898;7418.812989921586;7433.1080270367365;7436.1820199777985;7450.254974502506;7474.439417043689;4576.222042252825;4742.312364707098;4768.189407800683;4781.713097214179;4787.928181077286;7776.727814526521;7808.49244799092;7848.843023139562;7910.644021019068;7916.6833326666865;4822.638302127354;4841.878953026203;4850.75746212688;4851.902961940741;4874.19575770001;4092.6930480214105;4944.307796908436;4951.405831300195;4951.9752401237765;4955.529224723646;5341.706206158621;5449.754761035763;5953.255843019622;5953.553483488756;5971.5222782177325;7261.564306141543;7326.6702998364135;7415.703371865173;7438.5908775016815;7468.365188958999;1688.560974146706;1705.931762729477;1721.2942693495606;1722.1475369692082;1725.9309627614755;886.7162507997508;1012.5190534496203;1063.6064656077301;1073.1897417449775;1098.653924013933;6120.0207966726;6413.935860641333;6913.1358580177475;6919.792406227822;6993.2657071007825;7679.6160191990175;7680.923190768132;7685.730999414994;7702.961485192538;7721.305082542486;6917.9308206918295;6929.064576282138;6942.236354001056;6944.513884028171;6969.54697944632;3943.921121577552;4019.41718450823;4056.0671045659665;4061.91876162481;4075.9592404076175;8063.717769878026;8068.193180681885;8115.715949941724;8150.307223886036;8157.388195885333;6431.903521447182;7996.600169991477;8001.8799718004275;8061.596920153969;8094.190580941859;8120.269175774209;8137.104918458965;8164.7958801030445;8171.71399001044;8171.83656326882;7595.354394876276;7718.112417072109;7790.649420776192;7794.727184548514;7794.961025194838;6322.810315690536;7554.206808285051;7643;7684.538927664358;7685.577293248925;8036.799080022813;8100.756977290691;8137.430379873352;8143.104258531675;8198;3993.2412841560013;4826.975865120652;4861.635377346784;4873.512648735098;4889.486603906538;7486.326230639269;7733;7770.14528401864;7775.494592851446;7783.455158138876;7423.665935033045;7474.140473845578;7484.663190156347;7485.812854678677;7490.962545187239;7493.400527957641;7494.400447964041;7498.662560184914;7511.436642251962;7511.812204694927;7060.929390706027;7227.674754636159;7292.744753933587;7332.743353982585;7351.742689005859;7450.292222238879;7475.177730449537;7475.327220550176;7494.437917156344;7505.512141710771;7058.54119482232;7251.963740181265;7397.26027397256;7402.555846649218;7433.736264835099 03:00:11 INFO - PROCESS | 1662 | |5;yui.html;712.1987763765763;749.1497150733917;752.1087511299111;758.7154816943646;786.2569871471458;15408.460703875367;15449.536513904573;15681.999999999985;15692.764608530866;15719.84280157198;14114;14122.576322710309;14125.011249212559;14531.854681453182;14588.051776634511;765.5215490318551;938.7981583959447;940.5908429833028;964.6720115160844;964.7491652170417;804.8832919226738;951.2722767083187;957.9329446938717;960.2893858544696;965.4689920543708;975.4098770244007;997.421495532593;1007.566746299091;1013.3970287678856;1013.9188864890791;831.78789408701;981.3719219699398;1011.6206422591529;1013.1135256650431;1015.9695209143738;619.4332186049759;733.6918494232435;745.3329270303102;755.290027374272;756.7578374920027;15362.385504579803;15399.615009624737;15468;15533.301001454962;15729.606759830982;13340.466381344735;13364.665883352896;13470.663233419145;13481.191128532319;13570.389332480063;10128.291019628628;10474.42390668513;10549.683509494727;10559.683209503728;10599.470026498644;3640.581333146669;3667.2443674176775;3695.7597756146033;3741.5136032315627;3786.4698942147847;76425.6178719114;77622;78084;78170.60914695448;78356.60821695856;9184.448933064037;9571.521423928776;9696.272779541563;9835.508224588742;9999.650012249536;21261.255856044965;21454.785452145592;21658.35024949254;21697.56604867894;21738.456538586663;7478.887816682754;7674.616269186518;7719.961400193076;7810.101838288556;7993.600319984093;4171.770552619635;4222.039104052726;4320.546342633978;4360.738355698668;4371.540988196257;3791.1659434924272;3856.8650097247023;3861.903452413656;3865.16898866745;3876.6704830089757;675.7634827810227;690.6063543780098;704.8097013806243;706.7243774927782;706.9328413800681;593.7446897833972;600.5285850607253;612.0818771842237;619.7180282971237;627.0750642801922;8135.633896474673;8180;8188.222118898695;8197.754067377988;8452.28155606768;515.0754395859441;554.2351554854275;581.9679917604487;596.7195418153461;623.6133597169784;2938.3427267780808;3203.2312245061485;3496.3182179474757;3627.782333060025;3789.3936970084656;92213;92578.53710731538;92813.53593231991;93006.53496732473;93597.53201234086;77260.61369693228;79097.60451197707;79152;79713.60143199362;80003.19996799958;69575;70032.29967700258;70075.64962175259;70203.82590016065;71744;7512.586807725627;7569.499602859325;7750.844983100419;7796.986391769034;7990.240927111915;42147.99999999877;48470.78823029312;50857.74571127121;51030.23454648258;51630.272508309594;66476.66761666161;67593.32406675871;68004.65997670178;68401.2899677512;69628.6518567404;9877.30858839903;9882;9918.160754949587;10157.898421015696;10498.265121441425;11073.335599864035;11115.11079113685;11179.552817887194;11189.384583847966;11532.192746507664;10224.335418197794;10261.948690256799;10487.423191724529;10510.947445262726;10844.18668599874;10145.695629131138;10515.894841051797;10553.52509137106;10733.034026937301;11401.201915866142;10333.379997200193;10582.682519524427;10602.522886469973;10629.096526795;10807.189460790314;8921.776955576162;9064.909350906406;9206.815863682823;9209.17117459432;9432;7677.961610191914;9055.68305109318;9084;9110.180083792491;9145.176934075698 03:00:11 INFO - PROCESS | 1662 | __end_tp_report 03:00:11 INFO - PROCESS | 1662 | __start_cc_report 03:00:11 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,394 03:00:11 INFO - PROCESS | 1662 | __end_cc_report 03:00:11 INFO - PROCESS | 1662 | __startTimestamp1466589611713__endTimestamp 03:00:11 INFO - PROCESS | 1662 | 03:00:11 INFO - PROCESS | 1662 | ------- Summary: start ------- 03:00:11 INFO - PROCESS | 1662 | Number of tests: 6 03:00:11 INFO - PROCESS | 1662 | 03:00:11 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5905.70 Median:6161.26 stddev:663.96 (10.8%) stddev-sans-first:641.78 03:00:11 INFO - PROCESS | 1662 | Values: 3640.5 3682.6 3708.2 3729.6 3739.2 4476.7 5842.1 5878.8 6001.5 6044.8 6010.8 6018.5 6025.5 6057.0 6059.2 5328.1 5368.5 5403.4 5421.0 5553.5 5352.7 5416.4 5533.3 5589.4 5602.3 5395.7 5442.6 5468.6 5468.9 5503.6 4212.8 5455.8 5471.6 5473.5 5517.6 5206.3 5287.3 5305.1 5336.6 5409.6 4625.9 5839.9 5906.2 5913.2 5992.4 6265.8 6341.8 6360.7 6373.7 6379.8 6275.7 6356.8 6356.9 6382.3 6459.4 5025.5 6111.6 6118.7 6139.7 6140.0 6538.2 6547.4 6547.6 6570.8 6575.2 6161.3 6166.8 6229.3 6276.6 6277.6 6373.2 6378.4 6431.7 6432.5 6467.3 6313.3 6331.0 6332.7 6352.7 6354.7 6191.6 6280.6 6329.3 6329.4 6338.5 5069.6 5115.1 5115.1 5124.9 5125.2 4565.8 4598.2 4606.1 4646.6 4647.7 4989.7 6058.5 6109.3 6117.1 6159.4 6398.9 6429.7 6447.5 6454.0 6463.4 6046.4 6150.2 6153.4 6160.2 6167.3 4819.6 5574.9 5644.3 5666.2 5722.4 5229.8 6660.3 6666.8 6669.5 6678.3 6311.4 6381.7 6395.5 6446.7 6464.9 6619.0 6653.0 6664.4 6664.5 6675.0 6307.8 6321.9 6324.4 6329.1 6372.4 5792.0 6225.1 6293.7 6437.2 6443.0 5437.2 6249.0 6252.8 6279.2 6282.2 6194.6 6229.4 6246.7 6262.2 6275.2 5693.2 5886.6 6017.7 6110.9 6152.5 6229.0 6259.6 6285.5 6287.2 6291.6 6196.4 6234.0 6239.8 6240.4 6301.1 03:00:11 INFO - PROCESS | 1662 | 03:00:11 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:68280.07 Median:38886.81 stddev:145024.53 (372.9%) stddev-sans-first:145342.17 03:00:11 INFO - PROCESS | 1662 | Values: 535.2 545.4 574.5 576.7 626.5 39842.8 40746.0 40807.6 40843.8 41006.0 41262.6 41416.4 42069.6 42331.4 43061.0 9655.7 9821.5 9833.7 9859.5 9875.2 9830.7 9881.4 9953.5 9960.8 9980.0 9920.3 10003.4 10016.0 10042.9 10047.6 8776.1 9582.2 9923.0 9955.9 10000.1 9652.0 9733.8 9790.2 9812.2 9828.9 39140.8 39171.0 39365.4 39401.0 39924.0 3020.7 3274.9 3298.2 3406.9 3473.9 29548.6 29611.7 29826.9 30632.7 31526.8 2775.6 2787.6 2817.3 2851.1 2857.5 426087.0 426680.0 432451.8 432975.0 434936.0 66131.3 66225.7 66595.0 66621.7 66636.0 68089.0 70562.3 70619.0 72206.6 73676.0 18134.5 18779.2 18871.7 19024.6 19096.7 14082.0 14475.2 14501.9 14522.5 14526.9 20551.8 20836.5 20925.5 20943.6 20950.5 7812.0 7841.8 8587.0 8759.3 8840.5 956.0 1038.2 1040.2 1057.6 1138.6 24467.4 26156.6 30243.0 31082.4 31739.5 1102.5 1126.8 1139.2 1160.9 1179.9 13353.0 14380.9 14853.0 14905.8 15143.6 508149.5 621799.0 622856.0 643251.0 646331.8 59607.0 61599.7 61728.4 61799.0 62070.4 1363.6 1563.3 1572.4 1574.3 1598.6 29284.4 29345.0 29505.6 29636.7 30067.0 53157.7 53354.2 54191.0 54251.5 54530.0 557819.0 572593.0 576182.0 578031.3 578536.0 26699.2 26828.6 27569.9 27737.4 28072.9 45257.3 45820.8 46154.5 47019.8 47112.5 37444.0 38224.8 38240.6 38394.6 38838.6 37182.3 37790.8 37903.1 38020.8 38247.6 36156.8 37900.4 38935.0 39049.6 39084.4 31844.5 33129.5 33302.0 33663.0 33814.3 24962.4 25339.9 25378.6 25670.6 25758.4 03:00:11 INFO - PROCESS | 1662 | 03:00:11 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:36495.50 Median:11682.04 stddev:109070.47 (933.7%) stddev-sans-first:109342.79 03:00:11 INFO - PROCESS | 1662 | Values: 411.5 415.4 416.7 418.0 423.4 20509.6 21200.0 21221.3 21472.6 22530.5 12068.9 12189.6 12500.0 12502.0 12514.2 5339.1 5438.8 5482.7 5536.4 5585.0 5404.4 5530.1 5825.1 6105.5 6125.4 5899.4 5978.6 6113.8 6114.1 6959.8 6822.2 6843.0 6858.7 6899.9 6919.8 5598.2 5746.7 5935.6 6124.4 6174.2 14244.7 14412.0 14438.9 23946.0 26546.2 2147.5 2214.2 2235.4 2339.1 2365.9 9219.4 10383.4 10471.2 10472.6 10473.1 1802.6 1813.6 1828.3 1929.0 1936.8 106828.0 108070.0 109367.9 110490.6 111703.0 12067.0 12204.6 12220.7 12223.0 12233.0 15682.0 15812.9 15870.0 15880.6 15933.7 9431.9 9438.4 9557.1 9626.4 9673.0 8162.1 9235.3 9536.8 9582.8 9610.3 4793.5 4804.8 4817.0 4861.9 4917.3 2031.8 2115.4 2142.8 2176.7 2178.2 912.0 966.2 983.8 1058.0 1075.6 19980.1 20677.7 20948.8 21138.4 21168.5 987.9 1027.9 1028.5 1036.7 1073.0 9463.1 10353.5 11212.6 12076.9 12152.3 648535.0 654817.0 657178.0 657313.0 663956.0 104618.0 127194.0 142636.6 142998.0 144933.0 1046.5 1050.3 1062.0 1078.7 1082.4 18383.2 18472.8 18581.0 18640.8 18686.5 52877.5 53841.0 53980.7 54715.5 55293.0 78228.0 79673.0 83524.0 84160.6 84379.3 7387.6 8283.4 8405.6 8429.7 8442.6 12320.9 12812.4 12860.3 12957.5 13062.6 11183.2 11322.0 11341.9 11497.9 11498.9 9738.1 11129.5 11173.6 11375.4 11379.0 11425.5 11597.8 11736.0 11774.0 11815.4 8430.5 8475.3 8490.7 8526.7 8624.3 10918.3 11405.8 11408.3 11434.8 11613.1 03:00:11 INFO - PROCESS | 1662 | 03:00:11 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5830.87 Median:5106.14 stddev:3199.11 (62.7%) stddev-sans-first:3192.48 03:00:11 INFO - PROCESS | 1662 | Values: 1626.1 1638.0 1949.1 2026.6 2087.6 8128.0 8740.1 8874.8 9102.6 9131.5 8811.6 8837.3 8944.7 8948.0 8960.6 2143.7 2181.5 2435.9 2516.1 2530.8 2561.7 2571.7 2587.3 2600.0 2633.9 2540.7 2544.8 2566.5 2571.7 2579.1 2562.7 2578.6 2586.9 2598.5 2599.6 2180.8 2335.3 2570.5 2623.0 2630.9 8979.7 9094.0 9129.9 9174.5 9176.1 5601.2 5664.8 5698.2 5802.1 5812.5 3604.2 3670.7 3680.2 3747.3 3760.4 1033.3 1040.1 1042.1 1042.8 1050.0 11830.0 11884.9 12162.5 12366.3 12399.3 4963.1 5019.5 5118.7 5179.7 5222.6 10316.1 10346.9 10555.3 10673.6 10717.4 4876.0 5753.2 5779.0 5797.5 5801.8 4374.8 4578.5 5000.0 5000.9 5161.7 3559.4 4279.3 4299.2 4388.5 4389.5 1403.9 1439.9 1442.6 1443.3 1452.1 832.9 910.5 919.8 960.9 973.5 4595.6 5298.8 5890.7 6125.5 6154.7 839.4 947.9 949.4 971.6 996.4 4064.8 4115.2 4146.6 4178.8 4180.5 10705.4 10999.0 11033.3 11078.4 11190.2 10724.2 10730.4 10869.3 10927.5 11002.9 8370.2 8449.5 8479.2 8508.7 8598.7 5394.4 5931.9 6000.5 6114.6 6242.8 9252.0 9277.4 9296.4 9333.0 9490.3 8093.5 9640.8 9688.8 9767.0 9804.9 7378.4 7676.2 7694.8 7708.4 7814.8 7414.0 8328.1 8332.3 8363.7 8487.9 7403.3 7551.9 7607.2 7666.0 7669.6 6150.4 7398.9 7444.1 7453.4 7538.4 7065.0 7101.9 7164.8 7194.7 7222.8 4972.9 4977.1 5057.9 5090.3 5093.6 4700.7 4955.2 5031.1 5157.4 5220.6 03:00:11 INFO - PROCESS | 1662 | 03:00:11 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:6086.86 Median:6940.00 stddev:1978.58 (28.5%) stddev-sans-first:1936.48 03:00:11 INFO - PROCESS | 1662 | Values: 336.4 338.0 339.2 344.7 347.2 6440.3 6781.8 6937.8 6981.5 6986.5 6932.4 6979.1 6992.2 7013.6 7021.9 5154.8 5181.1 5185.5 5189.3 5200.7 5104.7 5200.8 5200.9 5212.0 5221.3 5154.0 5164.9 5172.1 5179.3 5184.0 4855.3 5024.7 5036.7 5163.6 5166.2 4260.6 4266.7 4268.6 4274.5 4293.8 6642.8 6648.1 6654.7 6689.7 6693.2 5942.9 5956.4 5965.4 5966.2 5967.9 7418.8 7433.1 7436.2 7450.3 7474.4 4576.2 4742.3 4768.2 4781.7 4787.9 7776.7 7808.5 7848.8 7910.6 7916.7 4822.6 4841.9 4850.8 4851.9 4874.2 4092.7 4944.3 4951.4 4952.0 4955.5 5341.7 5449.8 5953.3 5953.6 5971.5 7261.6 7326.7 7415.7 7438.6 7468.4 1688.6 1705.9 1721.3 1722.1 1725.9 886.7 1012.5 1063.6 1073.2 1098.7 6120.0 6413.9 6913.1 6919.8 6993.3 7679.6 7680.9 7685.7 7703.0 7721.3 6917.9 6929.1 6942.2 6944.5 6969.5 3943.9 4019.4 4056.1 4061.9 4076.0 8063.7 8068.2 8115.7 8150.3 8157.4 6431.9 7996.6 8001.9 8061.6 8094.2 8120.3 8137.1 8164.8 8171.7 8171.8 7595.4 7718.1 7790.6 7794.7 7795.0 6322.8 7554.2 7643.0 7684.5 7685.6 8036.8 8100.8 8137.4 8143.1 8198.0 3993.2 4827.0 4861.6 4873.5 4889.5 7486.3 7733.0 7770.1 7775.5 7783.5 7423.7 7474.1 7484.7 7485.8 7491.0 7493.4 7494.4 7498.7 7511.4 7511.8 7060.9 7227.7 7292.7 7332.7 7351.7 7450.3 7475.2 7475.3 7494.4 7505.5 7058.5 7252.0 7397.3 7402.6 7433.7 03:00:11 INFO - PROCESS | 1662 | 03:00:11 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18178.25 Median:619.58 stddev:25620.52 (4135.2%) stddev-sans-first:25658.82 03:00:11 INFO - PROCESS | 1662 | Values: 712.2 749.1 752.1 758.7 786.3 15408.5 15449.5 15682.0 15692.8 15719.8 14114.0 14122.6 14125.0 14531.9 14588.1 765.5 938.8 940.6 964.7 964.7 804.9 951.3 957.9 960.3 965.5 975.4 997.4 1007.6 1013.4 1013.9 831.8 981.4 1011.6 1013.1 1016.0 619.4 733.7 745.3 755.3 756.8 15362.4 15399.6 15468.0 15533.3 15729.6 13340.5 13364.7 13470.7 13481.2 13570.4 10128.3 10474.4 10549.7 10559.7 10599.5 3640.6 3667.2 3695.8 3741.5 3786.5 76425.6 77622.0 78084.0 78170.6 78356.6 9184.4 9571.5 9696.3 9835.5 9999.7 21261.3 21454.8 21658.4 21697.6 21738.5 7478.9 7674.6 7720.0 7810.1 7993.6 4171.8 4222.0 4320.5 4360.7 4371.5 3791.2 3856.9 3861.9 3865.2 3876.7 675.8 690.6 704.8 706.7 706.9 593.7 600.5 612.1 619.7 627.1 8135.6 8180.0 8188.2 8197.8 8452.3 515.1 554.2 582.0 596.7 623.6 2938.3 3203.2 3496.3 3627.8 3789.4 92213.0 92578.5 92813.5 93006.5 93597.5 77260.6 79097.6 79152.0 79713.6 80003.2 69575.0 70032.3 70075.6 70203.8 71744.0 7512.6 7569.5 7750.8 7797.0 7990.2 42148.0 48470.8 50857.7 51030.2 51630.3 66476.7 67593.3 68004.7 68401.3 69628.7 9877.3 9882.0 9918.2 10157.9 10498.3 11073.3 11115.1 11179.6 11189.4 11532.2 10224.3 10261.9 10487.4 10510.9 10844.2 10145.7 10515.9 10553.5 10733.0 11401.2 10333.4 10582.7 10602.5 10629.1 10807.2 8921.8 9064.9 9206.8 9209.2 9432.0 7678.0 9055.7 9084.0 9110.2 9145.2 03:00:11 INFO - PROCESS | 1662 | -------- Summary: end -------- 03:00:11 INFO - PROCESS | 1662 | 03:00:12 INFO - TEST-INFO | 1662: exit 0 03:00:12 INFO - TEST-OK | dromaeo_css | took 1110042ms 03:00:12 INFO - TEST-START | kraken 03:00:12 INFO - operating with platform_type : mac_ 03:00:12 INFO - Initialising browser for kraken test... 03:00:12 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmps1_9lO/profile http://localhost:49276/getInfo.html) 03:00:14 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 03:00:14 INFO - PROCESS | 1674 | colorDepth:24 03:00:14 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 03:00:14 INFO - PROCESS | 1674 | __metrics 03:00:14 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 03:00:15 INFO - TEST-INFO | 1674: exit 0 03:00:15 INFO - Browser initialized. 03:00:15 INFO - Running cycle 1/1 for kraken test... 03:00:15 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmps1_9lO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:27 INFO - PROCESS | 1678 | RSS: Main: 170872832 03:00:27 INFO - PROCESS | 1678 | 03:00:30 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 03:00:31 INFO - PROCESS | 1678 | RSS: Main: 183296000 03:00:31 INFO - PROCESS | 1678 | 03:00:33 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 03:00:34 INFO - PROCESS | 1678 | RSS: Main: 192389120 03:00:34 INFO - PROCESS | 1678 | 03:00:37 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 03:00:38 INFO - PROCESS | 1678 | RSS: Main: 195940352 03:00:38 INFO - PROCESS | 1678 | 03:00:40 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 03:00:41 INFO - PROCESS | 1678 | RSS: Main: 197222400 03:00:41 INFO - PROCESS | 1678 | 03:00:43 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:00:43 INFO - PROCESS | 1678 | RSS: Main: 197509120 03:00:43 INFO - PROCESS | 1678 | 03:00:46 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 03:00:47 INFO - PROCESS | 1678 | RSS: Main: 197779456 03:00:47 INFO - PROCESS | 1678 | 03:00:49 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 03:00:50 INFO - PROCESS | 1678 | RSS: Main: 197828608 03:00:50 INFO - PROCESS | 1678 | 03:00:53 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 03:00:54 INFO - PROCESS | 1678 | RSS: Main: 197996544 03:00:54 INFO - PROCESS | 1678 | 03:00:55 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:00:56 INFO - PROCESS | 1678 | RSS: Main: 197885952 03:00:56 INFO - PROCESS | 1678 | 03:00:58 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:00:58 INFO - PROCESS | 1678 | RSS: Main: 197373952 03:00:58 INFO - PROCESS | 1678 | 03:01:00 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:01:01 INFO - PROCESS | 1678 | RSS: Main: 197394432 03:01:01 INFO - PROCESS | 1678 | 03:01:04 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:01:05 INFO - PROCESS | 1678 | RSS: Main: 197586944 03:01:05 INFO - PROCESS | 1678 | 03:01:07 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:01:08 INFO - PROCESS | 1678 | RSS: Main: 197566464 03:01:08 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 03:01:10 INFO - PROCESS | 1678 | RSS: Main: 199315456 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | __start_tp_report 03:01:10 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 03:01:10 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 03:01:10 INFO - PROCESS | 1678 | |i|pagename|runs| 03:01:10 INFO - PROCESS | 1678 | |0;ai-astar;117;111;117;118;118;131;123;170;166;117 03:01:10 INFO - PROCESS | 1678 | |1;audio-beat-detection;154;124;145;161;134;172;139;120;180;150 03:01:10 INFO - PROCESS | 1678 | |2;audio-dft;194;196;197;202;194;194;241;284;224;199 03:01:10 INFO - PROCESS | 1678 | |3;audio-fft;65;80;76;143;60;55;59;64;126;55 03:01:10 INFO - PROCESS | 1678 | |4;audio-oscillator;77;83;122;77;79;78;115;78;80;114 03:01:10 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;91;88;89;89;90;89;94;87;91;86 03:01:10 INFO - PROCESS | 1678 | |6;imaging-darkroom;95;96;96;95;96;124;124;94;94;101 03:01:10 INFO - PROCESS | 1678 | |7;imaging-desaturate;89;91;89;89;93;89;123;87;145;151 03:01:10 INFO - PROCESS | 1678 | |8;json-parse-financial;59;65;62;63;82;72;92;102;92;89 03:01:10 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;64;63;64;69;65;69;76;69;64;65 03:01:10 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;81;80;81;82;80;80;82;80;82;83 03:01:10 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;153;143;114;150;137;141;140;147;171;149 03:01:10 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;218;163;165;186;214;172;159;199;178;163 03:01:10 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;68;65;64;67;85;103;95;76;68;64 03:01:10 INFO - PROCESS | 1678 | __end_tp_report 03:01:10 INFO - PROCESS | 1678 | __start_cc_report 03:01:10 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1056 03:01:10 INFO - PROCESS | 1678 | __end_cc_report 03:01:10 INFO - PROCESS | 1678 | __startTimestamp1466589670655__endTimestamp 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | ------- Summary: start ------- 03:01:10 INFO - PROCESS | 1678 | Number of tests: 14 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:128.80 Median:120.50 stddev:21.31 (17.7%) stddev-sans-first:22.17 03:01:10 INFO - PROCESS | 1678 | Values: 117.0 111.0 117.0 118.0 118.0 131.0 123.0 170.0 166.0 117.0 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:152.00 stddev:19.59 (12.9%) stddev-sans-first:20.66 03:01:10 INFO - PROCESS | 1678 | Values: 154.0 124.0 145.0 161.0 134.0 172.0 139.0 120.0 180.0 150.0 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:212.50 Median:200.50 stddev:29.61 (14.8%) stddev-sans-first:30.64 03:01:10 INFO - PROCESS | 1678 | Values: 194.0 196.0 197.0 202.0 194.0 194.0 241.0 284.0 224.0 199.0 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:78.30 Median:62.00 stddev:30.99 (50.0%) stddev-sans-first:32.50 03:01:10 INFO - PROCESS | 1678 | Values: 65.0 80.0 76.0 143.0 60.0 55.0 59.0 64.0 126.0 55.0 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:78.00 stddev:18.62 (23.9%) stddev-sans-first:19.12 03:01:10 INFO - PROCESS | 1678 | Values: 77.0 83.0 122.0 77.0 79.0 78.0 115.0 78.0 80.0 114.0 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:89.50 stddev:2.27 (2.5%) stddev-sans-first:2.33 03:01:10 INFO - PROCESS | 1678 | Values: 91.0 88.0 89.0 89.0 90.0 89.0 94.0 87.0 91.0 86.0 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:101.50 Median:95.00 stddev:12.02 (12.7%) stddev-sans-first:12.52 03:01:10 INFO - PROCESS | 1678 | Values: 95.0 96.0 96.0 95.0 96.0 124.0 124.0 94.0 94.0 101.0 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:104.60 Median:89.00 stddev:25.22 (28.3%) stddev-sans-first:26.12 03:01:10 INFO - PROCESS | 1678 | Values: 89.0 91.0 89.0 89.0 93.0 89.0 123.0 87.0 145.0 151.0 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:77.80 Median:77.00 stddev:15.46 (20.1%) stddev-sans-first:14.83 03:01:10 INFO - PROCESS | 1678 | Values: 59.0 65.0 62.0 63.0 82.0 72.0 92.0 102.0 92.0 89.0 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:3.99 (6.0%) stddev-sans-first:4.11 03:01:10 INFO - PROCESS | 1678 | Values: 64.0 63.0 64.0 69.0 65.0 69.0 76.0 69.0 64.0 65.0 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.50 stddev:1.10 (1.4%) stddev-sans-first:1.17 03:01:10 INFO - PROCESS | 1678 | Values: 81.0 80.0 81.0 82.0 80.0 80.0 82.0 80.0 82.0 83.0 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:148.00 stddev:14.35 (9.7%) stddev-sans-first:14.88 03:01:10 INFO - PROCESS | 1678 | Values: 153.0 143.0 114.0 150.0 137.0 141.0 140.0 147.0 171.0 149.0 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.70 Median:182.00 stddev:21.81 (12.0%) stddev-sans-first:18.76 03:01:10 INFO - PROCESS | 1678 | Values: 218.0 163.0 165.0 186.0 214.0 172.0 159.0 199.0 178.0 163.0 03:01:10 INFO - PROCESS | 1678 | 03:01:10 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.50 Median:68.00 stddev:14.09 (20.7%) stddev-sans-first:14.68 03:01:10 INFO - PROCESS | 1678 | Values: 68.0 65.0 64.0 67.0 85.0 103.0 95.0 76.0 68.0 64.0 03:01:10 INFO - PROCESS | 1678 | -------- Summary: end -------- 03:01:10 INFO - PROCESS | 1678 | 03:01:11 INFO - TEST-INFO | 1678: exit 0 03:01:11 INFO - TEST-OK | kraken | took 59241ms 03:01:11 INFO - SUITE-END | took 1169s 03:01:11 INFO - Completed test suite (00:19:29) 03:01:11 INFO - javascript benchmark 03:01:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3640.526731524901, 3682.594914559398, 3708.221273532558, 3729.5524537055558, 3739.214764899371, 4476.731396116235, 5842.123681447785, 5878.823635290937, 6001.489873360764, 6044.758209671608, 6010.849728756783, 6018.458338749511, 6025.548083893704, 6056.970315046442, 6059.151718759377, 5328.0675881720645, 5368.463153684639, 5403.432639572828, 5421.024215641183, 5553.500184983351, 5352.678839269656, 5416.4312747161575, 5533.335999680024, 5589.357223919261, 5602.271704678386, 5395.7032363220005, 5442.6462279951675, 5468.589855760814, 5468.890622187554, 5503.559715222793, 4212.7682977436225, 5455.754491047893, 5471.5896307776675, 5473.452654734535, 5517.641353312022, 5206.323177986876, 5287.259783630257, 5305.124654432014, 5336.573074154097, 5409.648372855751, 4625.930611040837, 5839.8540036499, 5906.173135760997, 5913.172155898178, 5992.400759924017, 6265.8120256392385, 6341.8414539636415, 6360.681965901686, 6373.713182906734, 6379.776707815204, 6275.717592708339, 6356.77751278703, 6356.904646430307, 6382.329855365213, 6459.386358295955, 5025.472325405816, 6111.602745821508, 6118.663473508956, 6139.723712432951, 6140.048292514667, 6538.1827271591055, 6547.410733033955, 6547.574407663486, 6570.770023049266, 6575.243846957661, 6161.260648722182, 6166.81499555014, 6229.2524897012645, 6276.560640755103, 6277.591956522811, 6373.235211774524, 6378.425941665272, 6431.678416079271, 6432.485401167895, 6467.320931302145, 6313.305536390993, 6331.0, 6332.715027823759, 6352.650604216812, 6354.745810167634, 6191.566590338633, 6280.560360774702, 6329.303776584572, 6329.367063293634, 6338.461230795342, 5069.569086627678, 5115.053715062725, 5115.0792857285305, 5124.897502050013, 5125.15434953236, 4565.840195593139, 4598.195315819785, 4606.124836281163, 4646.558576935186, 4647.674662773574, 4989.700617962933, 6058.545609079337, 6109.327973922865, 6117.143599896018, 6159.353267906895, 6398.872022559616, 6429.710663020175, 6447.548671593037, 6453.967730161413, 6463.418292353711, 6046.425589568984, 6150.169727086786, 6153.353897840662, 6160.199174107337, 6167.259928808572, 4819.59033482151, 5574.944250557523, 5644.266245388156, 5666.2350582670815, 5722.427757224327, 5229.790808367698, 6660.333966603398, 6666.799996000128, 6669.46644268467, 6678.298778628271, 6311.400416960381, 6381.680915954276, 6395.488360931021, 6446.67766611677, 6464.903026454701, 6618.966905165444, 6653.035309880137, 6664.366885145903, 6664.4668426524795, 6674.966625166843, 6307.779227727007, 6321.905171422341, 6324.367563243639, 6329.050642403677, 6372.394622510854, 5792.044312688359, 6225.097360882737, 6293.685315734287, 6437.195350581177, 6442.967785161231, 5437.238786569963, 6249.0, 6252.781152659635, 6279.246490421178, 6282.1519094921605, 6194.566380353332, 6229.4393504584805, 6246.656433895998, 6262.248530176408, 6275.184226050585, 5693.174489699053, 5886.646801191942, 6017.729202185825, 6110.923300256584, 6152.507799376129, 6228.968855155696, 6259.593126446766, 6285.465735412358, 6287.1512345832725, 6291.622502649856, 6196.380361963767, 6234.0, 6239.812805615838, 6240.4071613196675, 6301.149344838388], "value": 5868.679359220811, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.1785010009635, 545.3973359437821, 574.4743559642927, 576.708762075152, 626.4988009592328, 39842.80078599606, 40745.98135046625, 40807.59192408075, 40843.79578102113, 41005.97485062875, 41262.58737412625, 41416.378754318706, 42069.57930420695, 42331.3650295245, 43061.0, 9655.662051828187, 9821.459819709913, 9833.65582204623, 9859.507024648774, 9875.209983201363, 9830.705078847646, 9881.35771174875, 9953.502324883726, 9960.750981225456, 9979.950100249489, 9920.255980801432, 10003.449810260432, 10015.998400159962, 10042.949785251063, 10047.598096076148, 8776.078511756301, 9582.233421326277, 9922.950385248063, 9955.90044099557, 10000.149987251092, 9652.0, 9733.805323893483, 9790.167835733972, 9812.165965892907, 9828.901710982871, 39140.804295978334, 39171.0, 39365.40951885724, 39401.0, 39924.00189995244, 3020.7432368248506, 3274.9017529473917, 3298.2084299767885, 3406.8807591734417, 3473.930521389558, 29548.556771648444, 29611.703882961327, 29826.85086574553, 30632.693673063208, 31526.842365788023, 2775.639166908289, 2787.6097346371525, 2817.29567608098, 2851.0591504803365, 2857.5126696336933, 426087.0, 426680.0, 432451.83774081245, 432975.0, 434936.0, 66131.33868661252, 66225.66887165533, 66595.0, 66621.66689166523, 66636.0, 68089.0, 70562.2943770566, 70619.0, 72206.63896680484, 73676.0, 18134.5466363342, 18779.24883004692, 18871.716924246146, 19024.619507609772, 19096.71354929677, 14082.0, 14475.203863787592, 14501.912356573299, 14522.49171279, 14526.927365363317, 20551.79448205499, 20836.47908802292, 20925.476863078544, 20943.581128377347, 20950.47623809417, 7812.0, 7841.843163136706, 8587.0, 8759.255463285692, 8840.469571825712, 955.9866541466068, 1038.1746511523356, 1040.2250323508883, 1057.582255009267, 1138.6014894786758, 24467.38831529226, 26156.607650885253, 30243.0, 31082.378352433276, 31739.52390714141, 1102.5093833244289, 1126.830975353687, 1139.2196345503357, 1160.8606967163994, 1179.8820117988305, 13352.998525110655, 14380.85619143816, 14853.0, 14905.776413353808, 15143.561361670623, 508149.4592527014, 621799.0, 622856.0, 643251.0, 646331.7683411647, 59607.0, 61599.692001539705, 61728.382716172266, 61799.0, 62070.379296207364, 1363.5704753002772, 1563.3121426572272, 1572.3867691600515, 1574.3073047859134, 1598.5524053265103, 29284.414311714074, 29345.0, 29505.557416639196, 29636.703632963396, 30067.0, 53157.734211328694, 53354.19968700395, 54191.0, 54251.45748542464, 54530.0, 557819.0, 572593.0, 576182.0, 578031.3295300658, 578536.0, 26699.19902402931, 26828.59757103684, 27569.862150689118, 27737.44525109446, 28072.85963570251, 45257.32114018226, 45820.77089614664, 46154.53845461502, 47019.82450438767, 47112.52887471081, 37444.0, 38224.808875955445, 38240.61759382371, 38394.616053839105, 38838.6116138835, 37182.25635487221, 37790.811045945695, 37903.05242368963, 38020.80989595034, 38247.61752382552, 36156.81921590375, 37900.43149352817, 38935.0, 39049.60950390573, 39084.41373379459, 31844.5223321655, 33129.50305745464, 33302.0, 33663.0, 33814.3237135251, 24962.375940600905, 25339.87330063338, 25378.619320709833, 25670.61494077628, 25758.383709514157], "value": 20426.94736883733, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.500027466628, 415.40389541008653, 416.704140060557, 418.0364260379827, 423.43471465593433, 20509.589808203844, 21200.045997930112, 21221.257255996043, 21472.570548589018, 22530.549389012253, 12068.879311206907, 12189.573364932228, 12500.0, 12502.0, 12514.24914505128, 5339.119045357511, 5438.809641662542, 5482.698451585181, 5536.446355364452, 5584.972075139639, 5404.378496472897, 5530.142827861688, 5825.126231065353, 6105.481034112106, 6125.356837532062, 5899.380565040673, 5978.611390259641, 6113.847153821168, 6114.052321890092, 6959.826004349881, 6822.215445223788, 6842.965785171092, 6858.691358888862, 6899.931000690004, 6919.757808476729, 5598.1602759585985, 5746.655200687972, 5935.614185077956, 6124.387561243884, 6174.197354343952, 14244.715105697827, 14411.991160618762, 14438.855611443856, 23946.0, 26546.203613891616, 2147.5060736030646, 2214.1586197245106, 2235.441139715071, 2339.0994467130276, 2365.9171928982573, 9219.35464517484, 10383.42891140987, 10471.214658900537, 10472.633457828939, 10473.057424831726, 1802.5763945472804, 1813.555678858688, 1828.2686925229882, 1929.045122664276, 1936.845052395805, 106828.0, 108070.0, 109367.90632093657, 110490.6322076704, 111703.0, 12067.0, 12204.572839950559, 12220.694482637828, 12223.0, 12233.0, 15682.0, 15812.92093539525, 15870.047797132209, 15880.60298492547, 15933.68132637364, 9431.90568094324, 9438.38650487716, 9557.139857412867, 9626.422414655002, 9672.95163524192, 8162.14297498766, 9235.307351948632, 9536.809263814685, 9582.760430989281, 9610.327277090537, 4793.472718001017, 4804.81380971657, 4816.975915120472, 4861.854144375674, 4917.28699338601, 2031.837453003756, 2115.375964090597, 2142.828573714099, 2176.6734989751662, 2178.2267295110323, 911.9544022798833, 966.21253678252, 983.7983213441228, 1058.0, 1075.5590208014676, 19980.10089545974, 20677.689834652494, 20948.790512094987, 21138.365849024554, 21168.470788230417, 987.8567607696843, 1027.8715160604925, 1028.5371582787775, 1036.6682661548382, 1072.978540429187, 9463.064824188175, 10353.482325883675, 11212.607558735404, 12076.879231207751, 12152.270863748203, 648535.0, 654817.0, 657178.0, 657313.0, 663956.0, 104618.0, 127194.0, 142636.5736342644, 142998.0, 144933.0, 1046.5186014433293, 1050.3277902142636, 1061.984070238947, 1078.741102135482, 1082.420904815904, 18383.17275722569, 18472.81527184765, 18581.0, 18640.81359186445, 18686.53283667865, 52877.47122528879, 53841.0, 53980.73009634927, 54715.45284547104, 55293.0, 78228.0, 79673.0, 83524.0, 84160.57919710607, 84379.3124137526, 7387.630618468947, 8283.420160588701, 8405.621747021276, 8429.662813487637, 8442.620082096197, 12320.938395307967, 12812.423440945366, 12860.292683902475, 12957.546485872948, 13062.608121756362, 11183.161262905152, 11322.0, 11341.886581134084, 11497.942510287396, 11498.94250528742, 9738.123568878835, 11129.499172537417, 11173.608923687632, 11375.43122843838, 11379.0, 11425.542978280775, 11597.76804463923, 11736.0, 11773.99921006724, 11815.40922953866, 8430.45202061864, 8475.32197424217, 8490.745277641681, 8526.658933642833, 8624.310055195694, 10918.290311129751, 11405.828912566152, 11408.258463199865, 11434.828477572677, 11613.070954323803], "value": 9722.368032172237, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1626.1381467822055, 1637.959051023724, 1949.1326359769907, 2026.624871041981, 2087.6451003329435, 8127.9593602032055, 8740.125987401258, 8874.77813054674, 9102.590383432736, 9131.497767622786, 8811.559422028906, 8837.293016558677, 8944.686935957243, 8947.955260223689, 8960.596773145207, 2143.678448232762, 2181.4873504726374, 2435.890384932682, 2516.069054449847, 2530.7595778401023, 2561.70540387855, 2571.7299683533242, 2587.32729490332, 2600.0119954417296, 2633.8814753336146, 2540.6697129373156, 2544.7709706126443, 2566.5251928393213, 2571.7428257174224, 2579.0586435950836, 2562.654041704374, 2578.6003169508663, 2586.922392328233, 2598.4803039392195, 2599.558075127214, 2180.803727664502, 2335.346103091137, 2570.5373032854077, 2622.960655590168, 2630.907918222872, 8979.68571100015, 9094.0, 9129.908700912973, 9174.495402752913, 9176.082391760838, 5601.187827764992, 5664.830055098312, 5698.202251684767, 5802.12968054791, 5812.505936995361, 3604.189057462076, 3670.724695647837, 3680.245549662313, 3747.2880152770886, 3760.3607386744047, 1033.3438266700623, 1040.110705346925, 1042.0985847242157, 1042.8435734639788, 1050.033968748753, 11829.99445047172, 11884.940575297154, 12162.51349946001, 12366.258024518558, 12399.318037507934, 4963.131451995886, 5019.498050194951, 5118.692878427306, 5179.663321884065, 5222.55608273301, 10316.071553560065, 10346.948265258625, 10555.26113172086, 10673.626423075155, 10717.410542420243, 4876.0, 5753.165790960371, 5779.0, 5797.507211886952, 5801.767929282866, 4374.825006999748, 4578.496365399803, 5000.0, 5000.89998200034, 5161.74191290434, 3559.394902866467, 4279.315309550457, 4299.1831552005015, 4388.4733831940375, 4389.517153113155, 1403.943842246319, 1439.8992070554962, 1442.5960730995128, 1443.3216388297483, 1452.0924422236103, 832.937529685276, 910.5219759626249, 919.7537336908526, 960.8798900137483, 973.4986481961795, 4595.598342505501, 5298.81454149103, 5890.705464726747, 6125.540584456184, 6154.661493617894, 839.3704721458906, 947.924166066713, 949.3971328206501, 971.5676523946776, 996.3623281100101, 4064.837406503766, 4115.218108559364, 4146.606072423115, 4178.791060446965, 4180.540140584533, 10705.357678539312, 10999.0, 11033.337999720043, 11078.446077696082, 11190.216684832147, 10724.249302548902, 10730.409827459565, 10869.347839129678, 10927.453627318602, 11002.889971100347, 8370.204830541088, 8449.45078569891, 8479.236868681724, 8508.659653613786, 8598.699045533376, 5394.379646340721, 5931.9110213345975, 6000.459958603747, 6114.602550834359, 6242.781502647385, 9252.028537003787, 9277.350585459222, 9296.442213467213, 9333.0, 9490.288228383037, 8093.473924194908, 9640.807183856425, 9688.75778105553, 9767.023297670461, 9804.85292720624, 7378.409727221702, 7676.193999630182, 7694.769156925301, 7708.4218683600075, 7814.804629884298, 7414.0, 8328.08391076969, 8332.333413326798, 8363.707270245512, 8487.915120848713, 7403.296686814744, 7551.886721699069, 7607.16321204656, 7665.961670191613, 7669.61651917413, 6150.415710507495, 7398.889016664862, 7444.069491313586, 7453.366463850633, 7538.434617403607, 7065.0, 7101.857962840818, 7164.820879478055, 7194.748183813542, 7222.819429514094, 4972.8756781080765, 4977.129002424634, 5057.873553161053, 5090.312807770903, 5093.592512598909, 4700.670953033392, 4955.231939049453, 5031.094403007493, 5157.406898206755, 5220.556252718561], "value": 4733.464439545828, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.396168876866, 337.97087867443634, 339.22825571824103, 344.70734744707346, 347.18584918366423, 6440.259370172432, 6781.76263830766, 6937.757178498754, 6981.511294209401, 6986.510944233905, 6932.376086152245, 6979.092717946673, 6992.160940687112, 7013.649317534128, 7021.89467157993, 5154.819581314655, 5181.145111056671, 5185.533302002819, 5189.325387699603, 5200.713960732158, 5104.744762761866, 5200.843974680765, 5200.895982080356, 5212.0097181535575, 5221.269022336875, 5154.0, 5164.922526162091, 5172.146595811687, 5179.326687530615, 5184.0, 4855.344528488662, 5024.748762561857, 5036.722980236085, 5163.612729045318, 5166.199239117943, 4260.573942605714, 4266.679999000087, 4268.55180206077, 4274.465691788527, 4293.828246870122, 6642.833929151761, 6648.135742353463, 6654.6672666366485, 6689.698963546603, 6693.196816382066, 5942.910856337158, 5956.434138756811, 5965.403459654, 5966.224390829208, 5967.850803729898, 7418.812989921586, 7433.1080270367365, 7436.1820199777985, 7450.254974502506, 7474.439417043689, 4576.222042252825, 4742.312364707098, 4768.189407800683, 4781.713097214179, 4787.928181077286, 7776.727814526521, 7808.49244799092, 7848.843023139562, 7910.644021019068, 7916.6833326666865, 4822.638302127354, 4841.878953026203, 4850.75746212688, 4851.902961940741, 4874.19575770001, 4092.6930480214105, 4944.307796908436, 4951.405831300195, 4951.9752401237765, 4955.529224723646, 5341.706206158621, 5449.754761035763, 5953.255843019622, 5953.553483488756, 5971.5222782177325, 7261.564306141543, 7326.6702998364135, 7415.703371865173, 7438.5908775016815, 7468.365188958999, 1688.560974146706, 1705.931762729477, 1721.2942693495606, 1722.1475369692082, 1725.9309627614755, 886.7162507997508, 1012.5190534496203, 1063.6064656077301, 1073.1897417449775, 1098.653924013933, 6120.0207966726, 6413.935860641333, 6913.1358580177475, 6919.792406227822, 6993.2657071007825, 7679.6160191990175, 7680.923190768132, 7685.730999414994, 7702.961485192538, 7721.305082542486, 6917.9308206918295, 6929.064576282138, 6942.236354001056, 6944.513884028171, 6969.54697944632, 3943.921121577552, 4019.41718450823, 4056.0671045659665, 4061.91876162481, 4075.9592404076175, 8063.717769878026, 8068.193180681885, 8115.715949941724, 8150.307223886036, 8157.388195885333, 6431.903521447182, 7996.600169991477, 8001.8799718004275, 8061.596920153969, 8094.190580941859, 8120.269175774209, 8137.104918458965, 8164.7958801030445, 8171.71399001044, 8171.83656326882, 7595.354394876276, 7718.112417072109, 7790.649420776192, 7794.727184548514, 7794.961025194838, 6322.810315690536, 7554.206808285051, 7643.0, 7684.538927664358, 7685.577293248925, 8036.799080022813, 8100.756977290691, 8137.430379873352, 8143.104258531675, 8198.0, 3993.2412841560013, 4826.975865120652, 4861.635377346784, 4873.512648735098, 4889.486603906538, 7486.326230639269, 7733.0, 7770.14528401864, 7775.494592851446, 7783.455158138876, 7423.665935033045, 7474.140473845578, 7484.663190156347, 7485.812854678677, 7490.962545187239, 7493.400527957641, 7494.400447964041, 7498.662560184914, 7511.436642251962, 7511.812204694927, 7060.929390706027, 7227.674754636159, 7292.744753933587, 7332.743353982585, 7351.742689005859, 7450.292222238879, 7475.177730449537, 7475.327220550176, 7494.437917156344, 7505.512141710771, 7058.54119482232, 7251.963740181265, 7397.26027397256, 7402.555846649218, 7433.736264835099], "value": 5413.017150105727, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.1987763765763, 749.1497150733917, 752.1087511299111, 758.7154816943646, 786.2569871471458, 15408.460703875367, 15449.536513904573, 15681.999999999985, 15692.764608530866, 15719.84280157198, 14114.0, 14122.576322710309, 14125.011249212559, 14531.854681453182, 14588.051776634511, 765.5215490318551, 938.7981583959447, 940.5908429833028, 964.6720115160844, 964.7491652170417, 804.8832919226738, 951.2722767083187, 957.9329446938717, 960.2893858544696, 965.4689920543708, 975.4098770244007, 997.421495532593, 1007.566746299091, 1013.3970287678856, 1013.9188864890791, 831.78789408701, 981.3719219699398, 1011.6206422591529, 1013.1135256650431, 1015.9695209143738, 619.4332186049759, 733.6918494232435, 745.3329270303102, 755.290027374272, 756.7578374920027, 15362.385504579803, 15399.615009624737, 15468.0, 15533.301001454962, 15729.606759830982, 13340.466381344735, 13364.665883352896, 13470.663233419145, 13481.191128532319, 13570.389332480063, 10128.291019628628, 10474.42390668513, 10549.683509494727, 10559.683209503728, 10599.470026498644, 3640.581333146669, 3667.2443674176775, 3695.7597756146033, 3741.5136032315627, 3786.4698942147847, 76425.6178719114, 77622.0, 78084.0, 78170.60914695448, 78356.60821695856, 9184.448933064037, 9571.521423928776, 9696.272779541563, 9835.508224588742, 9999.650012249536, 21261.255856044965, 21454.785452145592, 21658.35024949254, 21697.56604867894, 21738.456538586663, 7478.887816682754, 7674.616269186518, 7719.961400193076, 7810.101838288556, 7993.600319984093, 4171.770552619635, 4222.039104052726, 4320.546342633978, 4360.738355698668, 4371.540988196257, 3791.1659434924272, 3856.8650097247023, 3861.903452413656, 3865.16898866745, 3876.6704830089757, 675.7634827810227, 690.6063543780098, 704.8097013806243, 706.7243774927782, 706.9328413800681, 593.7446897833972, 600.5285850607253, 612.0818771842237, 619.7180282971237, 627.0750642801922, 8135.633896474673, 8180.0, 8188.222118898695, 8197.754067377988, 8452.28155606768, 515.0754395859441, 554.2351554854275, 581.9679917604487, 596.7195418153461, 623.6133597169784, 2938.3427267780808, 3203.2312245061485, 3496.3182179474757, 3627.782333060025, 3789.3936970084656, 92213.0, 92578.53710731538, 92813.53593231991, 93006.53496732473, 93597.53201234086, 77260.61369693228, 79097.60451197707, 79152.0, 79713.60143199362, 80003.19996799958, 69575.0, 70032.29967700258, 70075.64962175259, 70203.82590016065, 71744.0, 7512.586807725627, 7569.499602859325, 7750.844983100419, 7796.986391769034, 7990.240927111915, 42147.99999999877, 48470.78823029312, 50857.74571127121, 51030.23454648258, 51630.272508309594, 66476.66761666161, 67593.32406675871, 68004.65997670178, 68401.2899677512, 69628.6518567404, 9877.30858839903, 9882.0, 9918.160754949587, 10157.898421015696, 10498.265121441425, 11073.335599864035, 11115.11079113685, 11179.552817887194, 11189.384583847966, 11532.192746507664, 10224.335418197794, 10261.948690256799, 10487.423191724529, 10510.947445262726, 10844.18668599874, 10145.695629131138, 10515.894841051797, 10553.52509137106, 10733.034026937301, 11401.201915866142, 10333.379997200193, 10582.682519524427, 10602.522886469973, 10629.096526795, 10807.189460790314, 8921.776955576162, 9064.909350906406, 9206.815863682823, 9209.17117459432, 9432.0, 7677.961610191914, 9055.68305109318, 9084.0, 9110.180083792491, 9145.176934075698], "value": 6908.505770514563, "unit": "score"}], "name": "dromaeo_css", "value": 7687.038515321327, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 117.0, 118.0, 118.0, 131.0, 123.0, 170.0, 166.0, 117.0], "value": 128.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 145.0, 161.0, 134.0, 172.0, 139.0, 120.0, 180.0, 150.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 196.0, 197.0, 202.0, 194.0, 194.0, 241.0, 284.0, 224.0, 199.0], "value": 212.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 80.0, 76.0, 143.0, 60.0, 55.0, 59.0, 64.0, 126.0, 55.0], "value": 78.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 83.0, 122.0, 77.0, 79.0, 78.0, 115.0, 78.0, 80.0, 114.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 89.0, 89.0, 90.0, 89.0, 94.0, 87.0, 91.0, 86.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 124.0, 124.0, 94.0, 94.0, 101.0], "value": 101.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 89.0, 89.0, 93.0, 89.0, 123.0, 87.0, 145.0, 151.0], "value": 104.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 65.0, 62.0, 63.0, 82.0, 72.0, 92.0, 102.0, 92.0, 89.0], "value": 77.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 69.0, 65.0, 69.0, 76.0, 69.0, 64.0, 65.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 82.0, 80.0, 80.0, 82.0, 80.0, 82.0, 83.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 143.0, 114.0, 150.0, 137.0, 141.0, 140.0, 147.0, 171.0, 149.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [218.0, 163.0, 165.0, 186.0, 214.0, 172.0, 159.0, 199.0, 178.0, 163.0], "value": 181.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 64.0, 67.0, 85.0, 103.0, 95.0, 76.0, 68.0, 64.0], "value": 75.5, "unit": "score"}], "name": "kraken", "value": 1580.6999999999998, "alertThreshold": 2.0}]} 03:01:11 INFO - Return code: 0 03:01:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:01:11 ERROR - # TBPL SUCCESS # 03:01:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:01:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:01:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:01:11 INFO - 2016-06-22 03:01:11.984 screenresolution[1683:10417] starting screenresolution argv=screenresolution get 03:01:11 INFO - 2016-06-22 03:01:11.987 screenresolution[1683:10417] Display 0: 1600x1200x32@60 03:01:11 INFO - 2016-06-22 03:01:11.993 screenresolution[1684:10420] starting screenresolution argv=screenresolution list 03:01:11 INFO - Available Modes on Display 0 03:01:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:01:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:01:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:01:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:01:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:01:12 INFO - Intel Iris: 03:01:12 INFO - Chipset Model: Intel Iris 03:01:12 INFO - Type: GPU 03:01:12 INFO - Bus: Built-In 03:01:12 INFO - VRAM (Dynamic, Max): 1536 MB 03:01:12 INFO - Vendor: Intel (0x8086) 03:01:12 INFO - Device ID: 0x0a2e 03:01:12 INFO - Revision ID: 0x0009 03:01:12 INFO - Displays: 03:01:12 INFO - Display: 03:01:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:01:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:01:12 INFO - Display Serial Number: 1600x1200 60 03:01:12 INFO - Main Display: Yes 03:01:12 INFO - Mirror: Off 03:01:12 INFO - Online: Yes 03:01:12 INFO - Rotation: Supported 03:01:12 INFO - Return code: 0 03:01:12 INFO - Running post-action listener: _resource_record_post_action 03:01:12 INFO - Running post-run listener: _resource_record_post_run 03:01:13 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 38102528; Write bytes: 495898112; Read time: 392; Write time: 1720 03:01:13 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 186055168; Write bytes: 184684544; Read time: 17331; Write time: 345 03:01:13 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 37172736; Write bytes: 299661312; Read time: 378; Write time: 1323 03:01:13 INFO - Running post-run listener: _upload_blobber_files 03:01:13 INFO - Blob upload gear active. 03:01:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:01:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:01:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:01:13 INFO - (blobuploader) - INFO - Open directory for files ... 03:01:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:01:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:01:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:14 INFO - (blobuploader) - INFO - Done attempting. 03:01:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:01:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:01:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:15 INFO - (blobuploader) - INFO - Done attempting. 03:01:15 INFO - (blobuploader) - INFO - Iteration through files over. 03:01:15 INFO - Return code: 0 03:01:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:01:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:01:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/360b728b41ddd32720ad667700832fe5a990fa77cf3d5c88d69c56182278480ae7e9df3e9a93977df2cd46bba0b603c0aaa88a959c15d34e36c20609f44ecce9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ff1587ff370d3f5379e8528b1d74c8a3fc9f85814a1398b0a23eb67aae5979e88ff1fb9fcd3b69108f11c0918ece330d5abfff149537c8ea7bd290194e82f07"} 03:01:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:01:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:01:15 INFO - Contents: 03:01:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/360b728b41ddd32720ad667700832fe5a990fa77cf3d5c88d69c56182278480ae7e9df3e9a93977df2cd46bba0b603c0aaa88a959c15d34e36c20609f44ecce9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ff1587ff370d3f5379e8528b1d74c8a3fc9f85814a1398b0a23eb67aae5979e88ff1fb9fcd3b69108f11c0918ece330d5abfff149537c8ea7bd290194e82f07"} 03:01:15 INFO - Running post-run listener: copy_logs_to_upload_dir 03:01:15 INFO - Copying logs to upload dir... 03:01:15 INFO - mkdir: /builds/slave/test/build/upload/logs 03:01:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.709375 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-22 03:01:16.024040) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 03:01:16.027876) ========= 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.UQUlIApWOb/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.W1eoVFdBHR/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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/360b728b41ddd32720ad667700832fe5a990fa77cf3d5c88d69c56182278480ae7e9df3e9a93977df2cd46bba0b603c0aaa88a959c15d34e36c20609f44ecce9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ff1587ff370d3f5379e8528b1d74c8a3fc9f85814a1398b0a23eb67aae5979e88ff1fb9fcd3b69108f11c0918ece330d5abfff149537c8ea7bd290194e82f07"} build_url:https://queue.taskcluster.net/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011082 build_url: 'https://queue.taskcluster.net/v1/task/NQnfZ03jQ9y5ayWJKsUiOg/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/360b728b41ddd32720ad667700832fe5a990fa77cf3d5c88d69c56182278480ae7e9df3e9a93977df2cd46bba0b603c0aaa88a959c15d34e36c20609f44ecce9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ff1587ff370d3f5379e8528b1d74c8a3fc9f85814a1398b0a23eb67aae5979e88ff1fb9fcd3b69108f11c0918ece330d5abfff149537c8ea7bd290194e82f07"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 03:01:16.065557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:01:16.066108) ========= 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.UQUlIApWOb/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.W1eoVFdBHR/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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.005132 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:01:16.117296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 03:01:16.117690) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 03:01:16.118177) ========= ========= Total master_lag: 0.18 =========