builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0329 starttime: 1468840994.24 results: success (0) buildid: 20160718022251 builduid: 72fb3d9a169a470cb4d3b09ac56c5523 revision: 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 04:23:14.239357) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 04:23:14.239728) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 04:23:14.239995) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 04:23:14.264373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:23:14.264659) ========= 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.Hzzi0ovxvt/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.mhD0OrpdCH/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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-07-18 04:23:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 136M=0s 2016-07-18 04:23:14 (136 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079794 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:23:14.372818) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:23:14.373109) ========= 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.Hzzi0ovxvt/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.mhD0OrpdCH/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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.026895 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:23:14.420800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 04:23:14.421122) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 --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 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Hzzi0ovxvt/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.mhD0OrpdCH/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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-07-18 04:23:14,502 truncating revision to first 12 chars 2016-07-18 04:23:14,502 Setting DEBUG logging. 2016-07-18 04:23:14,502 attempt 1/10 2016-07-18 04:23:14,502 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2b7160a603f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 04:23:15,577 unpacking tar archive at: mozilla-beta-2b7160a603f1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.333134 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 04:23:15.775921) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 04:23:15.776235) ========= script_repo_revision: 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 04:23:15.776634) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 04:23:15.776902) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 04:23:15.794630) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-18 04:23:15.794927) ========= /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.Hzzi0ovxvt/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.mhD0OrpdCH/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 04:23:15 INFO - MultiFileLogger online at 20160718 04:23:15 in /builds/slave/test 04:23:15 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 04:23:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:15 INFO - {'append_to_log': False, 04:23:15 INFO - 'base_work_dir': '/builds/slave/test', 04:23:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:23:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:15 INFO - 'branch': 'Mozilla-Beta', 04:23:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:15 INFO - 'config_files': ('talos/mac_config.py',), 04:23:15 INFO - 'default_actions': ('clobber', 04:23:15 INFO - 'read-buildbot-config', 04:23:15 INFO - 'download-and-extract', 04:23:15 INFO - 'populate-webroot', 04:23:15 INFO - 'create-virtualenv', 04:23:15 INFO - 'install', 04:23:15 INFO - 'run-tests'), 04:23:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:15 INFO - 'download_minidump_stackwalk': True, 04:23:15 INFO - 'download_symbols': 'ondemand', 04:23:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:15 INFO - 'installer_path': 'installer.exe', 04:23:15 INFO - 'log_level': 'info', 04:23:15 INFO - 'log_name': 'talos', 04:23:15 INFO - 'log_to_console': True, 04:23:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:23:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:23:15 INFO - 'opt_config_files': (), 04:23:15 INFO - 'pip_index': False, 04:23:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:23:15 INFO - 'cmd': ('bash', 04:23:15 INFO - '-c', 04:23:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:23:15 INFO - 'enabled': True, 04:23:15 INFO - 'halt_on_failure': False, 04:23:15 INFO - 'name': 'check_screen_resolution'},), 04:23:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:23:15 INFO - 'cmd': ('bash', 04:23:15 INFO - '-c', 04:23:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:23:15 INFO - 'enabled': True, 04:23:15 INFO - 'halt_on_failure': False, 04:23:15 INFO - 'name': 'check_screen_resolution'},), 04:23:15 INFO - 'run_cmd_checks_enabled': True, 04:23:15 INFO - 'sps_profile': False, 04:23:15 INFO - 'sps_profile_interval': 0, 04:23:15 INFO - 'suite': 'dromaeojs-e10s', 04:23:15 INFO - 'system_bits': '32', 04:23:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:15 INFO - 'title': 't-yosemite-r7-0329', 04:23:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:15 INFO - 'use_talos_json': True, 04:23:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:15 INFO - 'work_dir': 'build'} 04:23:15 INFO - ##### 04:23:15 INFO - ##### Running clobber step. 04:23:15 INFO - ##### 04:23:15 INFO - Running pre-action listener: _resource_record_pre_action 04:23:15 INFO - Running main action method: clobber 04:23:15 INFO - rmtree: /builds/slave/test/build 04:23:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:17 INFO - Running post-action listener: _resource_record_post_action 04:23:17 INFO - ##### 04:23:17 INFO - ##### Running read-buildbot-config step. 04:23:17 INFO - ##### 04:23:17 INFO - Running pre-action listener: _resource_record_pre_action 04:23:17 INFO - Running main action method: read_buildbot_config 04:23:17 INFO - Using buildbot properties: 04:23:17 INFO - { 04:23:17 INFO - "project": "", 04:23:17 INFO - "product": "firefox", 04:23:17 INFO - "script_repo_revision": "production", 04:23:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 04:23:17 INFO - "repository": "", 04:23:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 04:23:17 INFO - "buildid": "20160718022251", 04:23:17 INFO - "pgo_build": "False", 04:23:17 INFO - "basedir": "/builds/slave/test", 04:23:17 INFO - "buildnumber": 27, 04:23:17 INFO - "slavename": "t-yosemite-r7-0329", 04:23:17 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:23:17 INFO - "platform": "yosemite_r7", 04:23:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:23:17 INFO - "branch": "mozilla-beta", 04:23:17 INFO - "repo_path": "releases/mozilla-beta", 04:23:17 INFO - "revision": "2b7160a603f1f8f1fb5cef64dc73fb87c115bed7", 04:23:17 INFO - "stage_platform": "macosx64", 04:23:17 INFO - "builduid": "72fb3d9a169a470cb4d3b09ac56c5523", 04:23:17 INFO - "slavebuilddir": "test" 04:23:17 INFO - } 04:23:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 04:23:17 INFO - Running post-action listener: _resource_record_post_action 04:23:17 INFO - ##### 04:23:17 INFO - ##### Running download-and-extract step. 04:23:17 INFO - ##### 04:23:17 INFO - Running pre-action listener: _resource_record_pre_action 04:23:17 INFO - Running main action method: download_and_extract 04:23:17 INFO - mkdir: /builds/slave/test/build/tests 04:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:17 INFO - https://queue.taskcluster.net/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:23:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:23:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:23:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/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 04:23:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/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 04:23:18 INFO - Downloaded 1165 bytes. 04:23:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:23:18 INFO - Using the following test package requirements: 04:23:18 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:23:18 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:23:18 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 04:23:18 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:23:18 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 04:23:18 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:23:18 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:23:18 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 04:23:18 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:23:18 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:23:18 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 04:23:18 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:23:18 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 04:23:18 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:23:18 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 04:23:18 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:23:18 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 04:23:18 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 04:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:18 INFO - https://queue.taskcluster.net/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:23:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:23:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:23:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/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 04:23:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/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 04:23:20 INFO - Downloaded 18314781 bytes. 04:23:20 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'] 04:23:20 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 04:23:23 INFO - Return code: 0 04:23:23 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 04:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:23 INFO - https://queue.taskcluster.net/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:23:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:23:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:23:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/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 04:23:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/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 04:23:25 INFO - Downloaded 18314781 bytes. 04:23:25 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'] 04:23:25 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 04:23:28 INFO - Return code: 0 04:23: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')]} 04:23:28 INFO - https://queue.taskcluster.net/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:23:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:23:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:23:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/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 04:23:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/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 04:23:30 INFO - Downloaded 10840145 bytes. 04:23:30 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'] 04:23:30 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 04:23:30 INFO - Return code: 0 04:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:30 INFO - https://queue.taskcluster.net/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 04:23:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:23:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:23:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 04:23:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a2qSL45vSLu7hXYDr7nryQ/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 04:23:33 INFO - Downloaded 86191640 bytes. 04:23:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:23:33 INFO - mkdir: /builds/slave/test/properties 04:23:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:23:33 INFO - Writing to file /builds/slave/test/properties/build_url 04:23:33 INFO - Contents: 04:23:33 INFO - build_url:https://queue.taskcluster.net/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:23:35 INFO - Running post-action listener: _resource_record_post_action 04:23:35 INFO - Running post-action listener: set_extra_try_arguments 04:23:35 INFO - ##### 04:23:35 INFO - ##### Running populate-webroot step. 04:23:35 INFO - ##### 04:23:35 INFO - Running pre-action listener: _resource_record_pre_action 04:23:35 INFO - Running main action method: populate_webroot 04:23:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:23:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:23:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:23:35 INFO - '--tppagecycles', 04:23:35 INFO - '7'], 04:23:35 INFO - 'tests': ['tsvgm']}}, 04:23:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:23:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:23:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:23:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:23:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:23:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:23:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:35 INFO - 'talos_options': ['--disable-e10s'], 04:23:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:35 INFO - 'talos_options': ['--disable-e10s'], 04:23:35 INFO - 'tests': ['damp', 'tps']}, 04:23:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:35 INFO - 'tests': ['damp', 'tps']}, 04:23:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:23:35 INFO - 'tests': ['dromaeo_dom']}, 04:23:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:23:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:23:35 INFO - 'tests': ['a11yr', 04:23:35 INFO - 'ts_paint', 04:23:35 INFO - 'tpaint', 04:23:35 INFO - 'sessionrestore', 04:23:35 INFO - 'sessionrestore_no_auto_restore', 04:23:35 INFO - 'tabpaint']}, 04:23:35 INFO - 'other-e10s': {'tests': ['a11yr', 04:23:35 INFO - 'ts_paint', 04:23:35 INFO - 'tpaint', 04:23:35 INFO - 'sessionrestore', 04:23:35 INFO - 'sessionrestore_no_auto_restore', 04:23:35 INFO - 'tabpaint']}, 04:23:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:23:35 INFO - 'ts_paint', 04:23:35 INFO - 'tpaint', 04:23:35 INFO - 'sessionrestore', 04:23:35 INFO - 'sessionrestore_no_auto_restore', 04:23:35 INFO - 'tabpaint']}, 04:23:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:23:35 INFO - 'ts_paint', 04:23:35 INFO - 'tpaint', 04:23:35 INFO - 'sessionrestore', 04:23:35 INFO - 'sessionrestore_no_auto_restore', 04:23:35 INFO - 'tabpaint']}, 04:23:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:23:35 INFO - 'tests': ['a11yr', 04:23:35 INFO - 'ts_paint', 04:23:35 INFO - 'tpaint', 04:23:35 INFO - 'sessionrestore', 04:23:35 INFO - 'sessionrestore_no_auto_restore', 04:23:35 INFO - 'tabpaint']}, 04:23:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:23:35 INFO - 'tests': ['a11yr', 04:23:35 INFO - 'ts_paint', 04:23:35 INFO - 'tpaint', 04:23:35 INFO - 'sessionrestore', 04:23:35 INFO - 'sessionrestore_no_auto_restore', 04:23:35 INFO - 'tabpaint']}, 04:23:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:23:35 INFO - 'tests': ['tsvgx', 04:23:35 INFO - 'tsvgr_opacity', 04:23:35 INFO - 'tart', 04:23:35 INFO - 'tscrollx', 04:23:35 INFO - 'cart']}, 04:23:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:23:35 INFO - 'tsvgr_opacity', 04:23:35 INFO - 'tart', 04:23:35 INFO - 'tscrollx', 04:23:35 INFO - 'cart']}, 04:23:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:35 INFO - 'talos_options': ['--disable-e10s'], 04:23:35 INFO - 'tests': ['tp5o']}, 04:23:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:35 INFO - 'tests': ['tp5o']}, 04:23:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:35 INFO - 'talos_options': ['--disable-e10s', 04:23:35 INFO - '--xperf_path', 04:23:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:35 INFO - 'tests': ['tp5n']}, 04:23:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:35 INFO - 'talos_options': ['--xperf_path', 04:23:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:35 INFO - 'tests': ['tp5n']}}, 04:23:35 INFO - 'talos.zip': {'path': '', 04:23:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:23:35 INFO - Running post-action listener: _resource_record_post_action 04:23:35 INFO - ##### 04:23:35 INFO - ##### Running create-virtualenv step. 04:23:35 INFO - ##### 04:23:35 INFO - Running pre-action listener: _resource_record_pre_action 04:23:35 INFO - Running main action method: create_virtualenv 04:23:35 INFO - Creating virtualenv /builds/slave/test/build/venv 04:23:35 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 04:23:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:23:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:23:35 INFO - Using real prefix '/tools/python27' 04:23:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:23:35 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:38 INFO - Installing pip.................done. 04:23:38 INFO - Return code: 0 04:23:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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')]} 04:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:38 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 0x10c059a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c069420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8aad8bf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bef8e00>, '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 0x10bd61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bef3b20>, '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.Hzzi0ovxvt/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.mhD0OrpdCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 04:23:38 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 04:23:38 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 04:23:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hzzi0ovxvt/Render', 04:23:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:38 INFO - 'HOME': '/Users/cltbld', 04:23:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:38 INFO - 'LOGNAME': 'cltbld', 04:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:38 INFO - 'MOZ_NO_REMOTE': '1', 04:23:38 INFO - 'NO_EM_RESTART': '1', 04:23:38 INFO - 'PAGER': '/bin/cat', 04:23:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:38 INFO - 'PWD': '/builds/slave/test', 04:23:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:38 INFO - 'SHELL': '/bin/bash', 04:23:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhD0OrpdCH/Listeners', 04:23:38 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 04:23:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:38 INFO - 'USER': 'cltbld', 04:23:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:38 INFO - 'XPC_FLAGS': '0x0', 04:23:38 INFO - 'XPC_SERVICE_NAME': '0', 04:23:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:39 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 04:23:39 INFO - Cleaning up... 04:23:39 INFO - Return code: 0 04:23:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:39 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 0x10c059a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c069420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8aad8bf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bef8e00>, '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 0x10bd61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bef3b20>, '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.Hzzi0ovxvt/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.mhD0OrpdCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 04:23:39 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 04:23:39 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 04:23:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hzzi0ovxvt/Render', 04:23:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:39 INFO - 'HOME': '/Users/cltbld', 04:23:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:39 INFO - 'LOGNAME': 'cltbld', 04:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:39 INFO - 'MOZ_NO_REMOTE': '1', 04:23:39 INFO - 'NO_EM_RESTART': '1', 04:23:39 INFO - 'PAGER': '/bin/cat', 04:23:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:39 INFO - 'PWD': '/builds/slave/test', 04:23:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:39 INFO - 'SHELL': '/bin/bash', 04:23:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhD0OrpdCH/Listeners', 04:23:39 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 04:23:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:39 INFO - 'USER': 'cltbld', 04:23:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:39 INFO - 'XPC_FLAGS': '0x0', 04:23:39 INFO - 'XPC_SERVICE_NAME': '0', 04:23:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:39 INFO - Downloading/unpacking psutil>=0.7.1 04:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:42 INFO - Installing collected packages: psutil 04:23:42 INFO - Running setup.py install for psutil 04:23:42 INFO - building 'psutil._psutil_osx' extension 04:23:42 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 04:23:42 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 04:23:43 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 04:23:43 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 04:23:43 INFO - building 'psutil._psutil_posix' extension 04:23:43 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 04:23:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:23:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:23:43 INFO - ^ 04:23:43 INFO - 1 warning generated. 04:23:43 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 04:23:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:43 INFO - Successfully installed psutil 04:23:43 INFO - Cleaning up... 04:23:43 INFO - Return code: 0 04:23:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:23:43 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')]} 04:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:43 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')]} 04:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:43 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 0x10c059a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c069420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8aad8bf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bef8e00>, '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 0x10bd61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bef3b20>, '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.Hzzi0ovxvt/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.mhD0OrpdCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 04:23:43 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 04:23:43 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 04:23:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hzzi0ovxvt/Render', 04:23:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:43 INFO - 'HOME': '/Users/cltbld', 04:23:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:43 INFO - 'LOGNAME': 'cltbld', 04:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:43 INFO - 'MOZ_NO_REMOTE': '1', 04:23:43 INFO - 'NO_EM_RESTART': '1', 04:23:43 INFO - 'PAGER': '/bin/cat', 04:23:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:43 INFO - 'PWD': '/builds/slave/test', 04:23:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:43 INFO - 'SHELL': '/bin/bash', 04:23:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhD0OrpdCH/Listeners', 04:23:43 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 04:23:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:43 INFO - 'USER': 'cltbld', 04:23:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:43 INFO - 'XPC_FLAGS': '0x0', 04:23:43 INFO - 'XPC_SERVICE_NAME': '0', 04:23:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:23:43 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 04:23:43 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 04:23:43 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 04:23:43 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 04:23:43 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 04:23:43 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 04:23:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:23:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:23:46 INFO - Installing collected packages: mozsystemmonitor 04:23:46 INFO - Running setup.py install for mozsystemmonitor 04:23:46 INFO - Successfully installed mozsystemmonitor 04:23:46 INFO - Cleaning up... 04:23:46 INFO - Return code: 0 04:23:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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')]} 04:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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', '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 0x10c059a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c069420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8aad8bf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bef8e00>, '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 0x10bd61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bef3b20>, '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.Hzzi0ovxvt/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.mhD0OrpdCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 04:23: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:23: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 blobuploader==1.2.4 04:23:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hzzi0ovxvt/Render', 04:23:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:46 INFO - 'HOME': '/Users/cltbld', 04:23:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:46 INFO - 'LOGNAME': 'cltbld', 04:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:46 INFO - 'MOZ_NO_REMOTE': '1', 04:23:46 INFO - 'NO_EM_RESTART': '1', 04:23:46 INFO - 'PAGER': '/bin/cat', 04:23:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:46 INFO - 'PWD': '/builds/slave/test', 04:23:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:46 INFO - 'SHELL': '/bin/bash', 04:23:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhD0OrpdCH/Listeners', 04:23:46 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 04:23:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:46 INFO - 'USER': 'cltbld', 04:23:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:46 INFO - 'XPC_FLAGS': '0x0', 04:23:46 INFO - 'XPC_SERVICE_NAME': '0', 04:23:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:49 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:50 INFO - Downloading docopt-0.6.1.tar.gz 04:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:50 INFO - Running setup.py install for blobuploader 04:23:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:50 INFO - Running setup.py install for requests 04:23:51 INFO - Running setup.py install for docopt 04:23:51 INFO - Successfully installed blobuploader requests docopt 04:23:51 INFO - Cleaning up... 04:23:51 INFO - Return code: 0 04:23:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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')]} 04:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:51 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 0x10c059a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c069420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8aad8bf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bef8e00>, '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 0x10bd61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bef3b20>, '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.Hzzi0ovxvt/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.mhD0OrpdCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 04:23:51 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 04:23:51 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 04:23:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hzzi0ovxvt/Render', 04:23:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:51 INFO - 'HOME': '/Users/cltbld', 04:23:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:51 INFO - 'LOGNAME': 'cltbld', 04:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:51 INFO - 'MOZ_NO_REMOTE': '1', 04:23:51 INFO - 'NO_EM_RESTART': '1', 04:23:51 INFO - 'PAGER': '/bin/cat', 04:23:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:51 INFO - 'PWD': '/builds/slave/test', 04:23:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:51 INFO - 'SHELL': '/bin/bash', 04:23:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhD0OrpdCH/Listeners', 04:23:51 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 04:23:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:51 INFO - 'USER': 'cltbld', 04:23:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:51 INFO - 'XPC_FLAGS': '0x0', 04:23:51 INFO - 'XPC_SERVICE_NAME': '0', 04:23:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:51 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-NcxZqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:51 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-IJnA43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:51 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-ksuFqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:52 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-ugUALu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:52 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-UMcgYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:52 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-kiHAMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:52 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-VGQMkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:52 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-ebBklD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:52 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-qiiXMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:52 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-2NVHFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:52 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-tn1BFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:52 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-lRqjIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:52 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-OB2oMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:53 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-mIbLsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:53 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-xXg13z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:53 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-OdljPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:53 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-K7K5O1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:23:53 INFO - Running setup.py install for manifestparser 04:23:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:23:53 INFO - Running setup.py install for mozcrash 04:23:53 INFO - Running setup.py install for mozdebug 04:23:53 INFO - Running setup.py install for mozdevice 04:23:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:23:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:23:54 INFO - Running setup.py install for mozfile 04:23:54 INFO - Running setup.py install for mozhttpd 04:23:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:23:54 INFO - Running setup.py install for mozinfo 04:23:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:23:54 INFO - Running setup.py install for mozInstall 04:23:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:23:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:23:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:23:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:23:54 INFO - Running setup.py install for mozleak 04:23:54 INFO - Running setup.py install for mozlog 04:23:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:23:54 INFO - Running setup.py install for moznetwork 04:23:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:23:55 INFO - Running setup.py install for mozprocess 04:23:55 INFO - Running setup.py install for mozprofile 04:23:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:23:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:23:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:23:55 INFO - Running setup.py install for mozrunner 04:23:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:23:55 INFO - Running setup.py install for mozscreenshot 04:23:55 INFO - Running setup.py install for moztest 04:23:55 INFO - Running setup.py install for mozversion 04:23:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:23:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:23:55 INFO - Cleaning up... 04:23:56 INFO - Return code: 0 04:23:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:56 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 0x10c059a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c069420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8aad8bf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bef8e00>, '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 0x10bd61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bef3b20>, '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.Hzzi0ovxvt/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.mhD0OrpdCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 04:23:56 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 04:23:56 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 04:23:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hzzi0ovxvt/Render', 04:23:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:56 INFO - 'HOME': '/Users/cltbld', 04:23:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:56 INFO - 'LOGNAME': 'cltbld', 04:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:56 INFO - 'MOZ_NO_REMOTE': '1', 04:23:56 INFO - 'NO_EM_RESTART': '1', 04:23:56 INFO - 'PAGER': '/bin/cat', 04:23:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:56 INFO - 'PWD': '/builds/slave/test', 04:23:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:56 INFO - 'SHELL': '/bin/bash', 04:23:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhD0OrpdCH/Listeners', 04:23:56 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 04:23:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:56 INFO - 'USER': 'cltbld', 04:23:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:56 INFO - 'XPC_FLAGS': '0x0', 04:23:56 INFO - 'XPC_SERVICE_NAME': '0', 04:23:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:56 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-Al2aNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:56 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)) 04:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:56 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-E7bmxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:56 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)) 04:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:56 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-7t2J2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:56 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)) 04:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:56 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-U4oqQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:56 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)) 04:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:56 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-b2nXvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:56 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)) 04:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:56 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-lB7LXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:56 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)) 04:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:56 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-koYmFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:57 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)) 04:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:57 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-qcAU17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:57 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)) 04:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:57 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-Xjx1G5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:57 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)) 04:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:57 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-DfNJDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:57 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)) 04:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:57 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-xCFzYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:57 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)) 04:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:57 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-2rogVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:57 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)) 04:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:57 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-B_6Ebq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:57 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)) 04:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:57 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-3D_lua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:57 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)) 04:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:57 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-J9okUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:57 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)) 04:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:57 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-63mvRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:57 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)) 04:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:57 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-VaYD9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:58 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)) 04:23:58 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)) 04:23:58 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)) 04:23:58 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)) 04:23:58 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)) 04:23:58 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)) 04:23:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:24:00 INFO - Downloading blessings-1.6.tar.gz 04:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:24:00 INFO - Installing collected packages: blessings 04:24:00 INFO - Running setup.py install for blessings 04:24:00 INFO - Successfully installed blessings 04:24:00 INFO - Cleaning up... 04:24:00 INFO - Return code: 0 04:24:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:24:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:01 INFO - Reading from file tmpfile_stdout 04:24:01 INFO - Current package versions: 04:24:01 INFO - blessings == 1.6 04:24:01 INFO - blobuploader == 1.2.4 04:24:01 INFO - docopt == 0.6.1 04:24:01 INFO - manifestparser == 1.1 04:24:01 INFO - mozInstall == 1.12 04:24:01 INFO - mozcrash == 0.17 04:24:01 INFO - mozdebug == 0.1 04:24:01 INFO - mozdevice == 0.48 04:24:01 INFO - mozfile == 1.2 04:24:01 INFO - mozhttpd == 0.7 04:24:01 INFO - mozinfo == 0.9 04:24:01 INFO - mozleak == 0.1 04:24:01 INFO - mozlog == 3.1 04:24:01 INFO - moznetwork == 0.27 04:24:01 INFO - mozprocess == 0.22 04:24:01 INFO - mozprofile == 0.28 04:24:01 INFO - mozrunner == 6.11 04:24:01 INFO - mozscreenshot == 0.1 04:24:01 INFO - mozsystemmonitor == 0.0 04:24:01 INFO - moztest == 0.7 04:24:01 INFO - mozversion == 1.4 04:24:01 INFO - psutil == 3.1.1 04:24:01 INFO - requests == 1.2.3 04:24:01 INFO - wsgiref == 0.1.2 04:24:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:01 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')]} 04:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:01 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')]} 04:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:01 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 0x10c059a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c069420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8aad8bf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bef8e00>, '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 0x10bd61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bef3b20>, '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.Hzzi0ovxvt/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.mhD0OrpdCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 04:24:01 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 04:24:01 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 04:24:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hzzi0ovxvt/Render', 04:24:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:01 INFO - 'HOME': '/Users/cltbld', 04:24:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:01 INFO - 'LOGNAME': 'cltbld', 04:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:01 INFO - 'MOZ_NO_REMOTE': '1', 04:24:01 INFO - 'NO_EM_RESTART': '1', 04:24:01 INFO - 'PAGER': '/bin/cat', 04:24:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:01 INFO - 'PWD': '/builds/slave/test', 04:24:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:01 INFO - 'SHELL': '/bin/bash', 04:24:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhD0OrpdCH/Listeners', 04:24:01 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 04:24:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:01 INFO - 'USER': 'cltbld', 04:24:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:01 INFO - 'XPC_FLAGS': '0x0', 04:24:01 INFO - 'XPC_SERVICE_NAME': '0', 04:24:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:01 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)) 04:24:01 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)) 04:24:01 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)) 04:24:01 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)) 04:24:01 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)) 04:24:01 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)) 04:24:01 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)) 04:24:01 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)) 04:24:01 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)) 04:24:01 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)) 04:24:01 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)) 04:24:01 INFO - Cleaning up... 04:24:01 INFO - Return code: 0 04:24:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:24:01 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')]} 04:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:01 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')]} 04:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:01 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 0x10c059a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c069420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8aad8bf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bef8e00>, '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 0x10bd61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bef3b20>, '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.Hzzi0ovxvt/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.mhD0OrpdCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 04:24:01 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 04:24:01 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 04:24:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hzzi0ovxvt/Render', 04:24:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:01 INFO - 'HOME': '/Users/cltbld', 04:24:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:01 INFO - 'LOGNAME': 'cltbld', 04:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:01 INFO - 'MOZ_NO_REMOTE': '1', 04:24:01 INFO - 'NO_EM_RESTART': '1', 04:24:01 INFO - 'PAGER': '/bin/cat', 04:24:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:01 INFO - 'PWD': '/builds/slave/test', 04:24:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:01 INFO - 'SHELL': '/bin/bash', 04:24:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhD0OrpdCH/Listeners', 04:24:01 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 04:24:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:01 INFO - 'USER': 'cltbld', 04:24:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:01 INFO - 'XPC_FLAGS': '0x0', 04:24:01 INFO - 'XPC_SERVICE_NAME': '0', 04:24:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:01 INFO - Downloading/unpacking jsonschema 04:24:01 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 04:24:01 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 04:24:01 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 04:24:01 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 04:24:01 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 04:24:01 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 04:24:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:24:04 INFO - Downloading/unpacking functools32 (from jsonschema) 04:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:24:04 INFO - warning: no files found matching '*.txt' 04:24:04 INFO - no previously-included directories found matching 'build' 04:24:04 INFO - no previously-included directories found matching 'dist' 04:24:04 INFO - no previously-included directories found matching '.git*' 04:24:04 INFO - Installing collected packages: jsonschema, functools32 04:24:04 INFO - Running setup.py install for functools32 04:24:04 INFO - warning: no files found matching '*.txt' 04:24:04 INFO - no previously-included directories found matching 'build' 04:24:04 INFO - no previously-included directories found matching 'dist' 04:24:04 INFO - no previously-included directories found matching '.git*' 04:24:04 INFO - Successfully installed jsonschema functools32 04:24:04 INFO - Cleaning up... 04:24:04 INFO - Return code: 0 04:24:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:24: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')]} 04:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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')]} 04:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:04 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 0x10c059a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c069420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8aad8bf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bef8e00>, '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 0x10bd61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bef3b20>, '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.Hzzi0ovxvt/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.mhD0OrpdCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 04:24:04 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 04:24:04 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 04:24:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hzzi0ovxvt/Render', 04:24:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:04 INFO - 'HOME': '/Users/cltbld', 04:24:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:04 INFO - 'LOGNAME': 'cltbld', 04:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:04 INFO - 'MOZ_NO_REMOTE': '1', 04:24:04 INFO - 'NO_EM_RESTART': '1', 04:24:04 INFO - 'PAGER': '/bin/cat', 04:24:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:04 INFO - 'PWD': '/builds/slave/test', 04:24:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:04 INFO - 'SHELL': '/bin/bash', 04:24:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhD0OrpdCH/Listeners', 04:24:04 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 04:24:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:04 INFO - 'USER': 'cltbld', 04:24:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:04 INFO - 'XPC_FLAGS': '0x0', 04:24:04 INFO - 'XPC_SERVICE_NAME': '0', 04:24:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:05 INFO - Downloading/unpacking flake8 04:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:24:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:24:07 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 04:24:07 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 04:24:07 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 04:24:07 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 04:24:07 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 04:24:07 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 04:24:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:24:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:24:07 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 04:24:07 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 04:24:07 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 04:24:07 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 04:24:07 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 04:24:07 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 04:24:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:24:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:24:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:24:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:24:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:24:08 INFO - no previously-included directories found matching 'docs/_build' 04:24:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:24:08 INFO - Running setup.py install for pep8 04:24:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:24:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:24:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:24:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:24:08 INFO - no previously-included directories found matching 'docs/_build' 04:24:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:24:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:24:09 INFO - Cleaning up... 04:24:09 INFO - Return code: 0 04:24:09 INFO - Running post-action listener: _resource_record_post_action 04:24:09 INFO - Running post-action listener: _start_resource_monitoring 04:24:09 INFO - Starting resource monitoring. 04:24:09 INFO - ##### 04:24:09 INFO - ##### Running install step. 04:24:09 INFO - ##### 04:24:09 INFO - Running pre-action listener: _resource_record_pre_action 04:24:09 INFO - Running main action method: install 04:24:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:09 INFO - Reading from file tmpfile_stdout 04:24:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:24:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:24:09 INFO - Reading from file tmpfile_stdout 04:24:09 INFO - Output received: 04:24:09 INFO - Usage: mozinstall [options] installer 04:24:09 INFO - Options: 04:24:09 INFO - -h, --help show this help message and exit 04:24:09 INFO - -d DEST, --destination=DEST 04:24:09 INFO - Directory to install application into. [default: 04:24:09 INFO - "/builds/slave/test"] 04:24:09 INFO - --app=APP Application being installed. [default: firefox] 04:24:09 INFO - mkdir: /builds/slave/test/build/application 04:24:09 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'] 04:24:09 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 04:24:31 INFO - Reading from file tmpfile_stdout 04:24:31 INFO - Output received: 04:24:31 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:24:31 INFO - Running post-action listener: _resource_record_post_action 04:24:31 INFO - ##### 04:24:31 INFO - ##### Running run-tests step. 04:24:31 INFO - ##### 04:24:31 INFO - Running pre-action listener: _resource_record_pre_action 04:24:31 INFO - Running main action method: run_tests 04:24:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:24:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:24:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:24:31 INFO - 2016-07-18 04:24:31.627 screenresolution[1642:7677] starting screenresolution argv=screenresolution get 04:24:31 INFO - 2016-07-18 04:24:31.630 screenresolution[1642:7677] Display 0: 1600x1200x32@60 04:24:31 INFO - 2016-07-18 04:24:31.636 screenresolution[1643:7679] starting screenresolution argv=screenresolution list 04:24:31 INFO - Available Modes on Display 0 04:24:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:24:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:24:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:24:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:24:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:24:31 INFO - Intel Iris: 04:24:31 INFO - Chipset Model: Intel Iris 04:24:31 INFO - Type: GPU 04:24:31 INFO - Bus: Built-In 04:24:31 INFO - VRAM (Dynamic, Max): 1536 MB 04:24:31 INFO - Vendor: Intel (0x8086) 04:24:31 INFO - Device ID: 0x0a2e 04:24:31 INFO - Revision ID: 0x0009 04:24:31 INFO - Displays: 04:24:31 INFO - Display: 04:24:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:24:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:24:31 INFO - Display Serial Number: 1600x1200 60 04:24:31 INFO - Main Display: Yes 04:24:31 INFO - Mirror: Off 04:24:31 INFO - Online: Yes 04:24:31 INFO - Rotation: Supported 04:24:31 INFO - Return code: 0 04:24:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:24:31 INFO - Python 2.7.3 04:24:31 INFO - Return code: 0 04:24:31 INFO - grabbing minidump binary from tooltool 04:24:31 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')]} 04:24:31 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 0x10bef8e00>, '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 0x10bd61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bef3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:24:31 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 04:24:31 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 04:24:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:24:31 INFO - Return code: 0 04:24:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:24:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:24:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:24:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:24:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:24:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:24:33 INFO - Return code: 0 04:24:33 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/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0329', '--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 04:24:33 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/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0329 --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 04:24:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hzzi0ovxvt/Render', 04:24:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:33 INFO - 'HOME': '/Users/cltbld', 04:24:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:33 INFO - 'LOGNAME': 'cltbld', 04:24:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:24:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:33 INFO - 'MOZ_NO_REMOTE': '1', 04:24:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:24:33 INFO - 'NO_EM_RESTART': '1', 04:24:33 INFO - 'PAGER': '/bin/cat', 04:24:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:33 INFO - 'PWD': '/builds/slave/test', 04:24:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:24:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:33 INFO - 'SHELL': '/bin/bash', 04:24:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhD0OrpdCH/Listeners', 04:24:33 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 04:24:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:33 INFO - 'USER': 'cltbld', 04:24:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:33 INFO - 'XPC_FLAGS': '0x0', 04:24:33 INFO - 'XPC_SERVICE_NAME': '0', 04:24:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:33 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/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0329', '--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 04:24:33 INFO - mozversion application_buildid: 20160718022251 04:24:33 INFO - mozversion application_changeset: 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 04:24:33 INFO - mozversion application_display_name: Firefox 04:24:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:24:33 INFO - mozversion application_name: Firefox 04:24:33 INFO - mozversion application_remotingname: firefox 04:24:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:24:33 INFO - mozversion application_vendor: Mozilla 04:24:33 INFO - mozversion application_version: 48.0 04:24:33 INFO - mozversion platform_buildid: 20160718022251 04:24:33 INFO - mozversion platform_changeset: 2b7160a603f1f8f1fb5cef64dc73fb87c115bed7 04:24:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:24:33 INFO - mozversion platform_version: 48.0 04:24:33 INFO - using testdate: 1468841073 04:24:33 INFO - actual date: 1468841073 04:24:33 INFO - starting webserver on 'localhost:49275' 04:24:33 INFO - SUITE-START | Running 2 tests 04:24:33 INFO - TEST-START | dromaeo_css 04:24:33 INFO - operating with platform_type : mac_ 04:24:33 INFO - Initialising browser for dromaeo_css test... 04:24:33 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmp90jlW_/profile http://localhost:49275/getInfo.html) 04:24:36 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 04:24:36 INFO - PROCESS | 1661 | colorDepth:24 04:24:36 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 04:24:36 INFO - PROCESS | 1661 | __metrics 04:24:36 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:24:37 INFO - TEST-INFO | 1661: exit 0 04:24:37 INFO - Browser initialized. 04:24:37 INFO - Running cycle 1/1 for dromaeo_css test... 04:24:37 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmp90jlW_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:49 INFO - PROCESS | 1666 | RSS: Main: 170967040 04:24:49 INFO - PROCESS | 1666 | 04:25:38 INFO - PROCESS | 1666 | 1468841138734 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] 04:27:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 04:27:49 INFO - PROCESS | 1666 | RSS: Main: 181653504 04:27:49 INFO - PROCESS | 1666 | 04:30:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 04:30:52 INFO - PROCESS | 1666 | RSS: Main: 192532480 04:30:52 INFO - PROCESS | 1666 | 04:33:54 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 04:33:54 INFO - PROCESS | 1666 | RSS: Main: 194723840 04:33:54 INFO - PROCESS | 1666 | 04:36:56 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 04:36:56 INFO - PROCESS | 1666 | RSS: Main: 198434816 04:36:56 INFO - PROCESS | 1666 | 04:39:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 04:40:00 INFO - PROCESS | 1666 | RSS: Main: 197496832 04:40:00 INFO - PROCESS | 1666 | 04:43:02 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 04:43:02 INFO - PROCESS | 1666 | RSS: Main: 203304960 04:43:02 INFO - PROCESS | 1666 | 04:43:02 INFO - PROCESS | 1666 | __start_tp_report 04:43:02 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 04:43:02 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 04:43:02 INFO - PROCESS | 1666 | |i|pagename|runs| 04:43:02 INFO - PROCESS | 1666 | |0;dojo.html;3613.2231570212407;3663.4321680139556;3663.6519530644587;3693.630636936307;3708.7218458615594;5848.766049358021;5864.618799778012;5903.704814759261;5933.22868027157;5943.197668314781;5879.52963762899;5925.437083477073;5937.85155371116;5941.079132734422;5944.673042982634;5333.466653334654;5345.4387289334545;5366.034113859504;5380.166074258496;5434.619576629638;5342.091844386464;5387.4612538746005;5407.810726624569;5423.755930983115;5518.944810551903;5414.3232095988005;5431.728413579305;5455.672659640414;5499.917501237464;5540.058190107671;5475.206095116206;5481.588880833953;5504.2294078829;5504.752286147133;5506.421825708283;5309.52214300711;5366.168243922199;5408.540274076709;5414.729263536808;5492.615516913817;4498.8425405110665;4835.951640483585;5745.454181852718;5777.537796976232;5976.641401515923;6205.815393218062;6231.408016238495;6232.657203853786;6233.563650544464;6240.31356550779;6276.309605943343;6278.434940855345;6283.874322513524;6302.243730752293;6308.905366419507;5979.940200597982;6073;6116.335771508194;6167.506599472032;6168.19813424252;6521.6413097279155;6521.934780652227;6541.313162118005;6547.985062315349;6554.639494827735;6189.96905015472;6247.5939063960695;6256.5307601930035;6257.530685198628;6262.5616206866;6278.183836101278;6348.587341822859;6358.078078678565;6371.904421433682;6372.044193371032;6255.343188965184;6256.7810126645345;6263.874722505524;6281.654509002049;6284.717187726564;6171.1668924694595;6218.968905155445;6229.626222426669;6284.622922624657;6291.5281353898645;5019.899602007939;5122.92315615266;5130.717810520383;5139.820106296336;5144.6398752087;4576.130535198302;4627.791749371287;4628;4644.9767751161025;4649.279361698942;4524.615407690383;5145.974270128625;5525.226468294442;5661.858453538694;6056.515478761688;5983.760649573968;6070.694800617888;6382.744690212432;6404.135441715402;6414.166158399472;6097.542684298695;6139.693015349215;6141.6007959482495;6157.384261573897;6177.289611694623;4783.689060211075;5508.55931525477;5577.832665020056;5637.408072152447;5667.546596272371;6584.835379115465;6588.7364505421165;6599.340065993362;6614.173228346457;6618.900716489256;5414.918776218438;6009.978303688296;6381.936180638134;6403.775867844603;6415.133956915756;6462.773802916875;6526.902096468461;6541.672916354068;6644.900326495203;6652;5262.842114736564;6240.656763878031;6242.500599951902;6277.2781130170615;6281.340459251713;6271.3415091414745;6331.873362532631;6399.424051835357;6407.839804004937;6420.422162005442;6124.0201567748945;6143.757528501975;6186.721597528032;6188.226471691039;6229.657368844576;5193.454687257784;6230.937690623035;6238.407351301619;6240.188775459162;6251.124842521959;5905.527557795452;6190.133381326708;6222.377762223741;6253.437190652863;6263.937360626335;6150.846228844314;6199.442050215503;6235.937640623536;6237.844053898689;6272.655003974825;6188.1027251049245;6218.098375735583;6232.844178895564;6242.875142497215;6243.937560624336 04:43:02 INFO - PROCESS | 1666 | |1;ext.html;534.6257619666233;554.4427850010738;561.1330494386174;603.879224155169;609.3753902250193;39820.80089599552;40661.39007914876;41269;41343.586564134384;41366.37950430742;44314.556854431445;44722.77638611811;45241.773791130996;45419.772901135446;45700.77149614247;9658.806823863537;9737.074977877126;9779.559919803625;9896.307258491872;9923.950380248125;9781.804363912717;9781.853272200922;9819.901800982007;9906.405615663083;9909.603615855358;9759.853602195974;9809.117179453848;9862.506874656274;9917.950410247939;9959.302848800588;9817.410955342631;9821.90178098217;9869.654562090329;9903.950480247624;9936.354136981145;9772.804543909153;9788.706338809847;9876;9907;9923.65267215644;40823.59176408227;41004;41151;41323;41488.58511414877;3348.0458069450333;3506.8421921013614;3541.557305336833;3883.8834834954996;3896.1428485733095;27998.5800212997;28727.569086463718;28760.712392876012;28916;29223.853880730672;2787.8048536602446;2798.4822807780624;2823.350629355239;2864.957025644617;2912.504874171396;467151;470304;470441;470747;474281.62859185826;38042.04894877595;38530.80734596309;38678.61321386806;68149.65925170343;69127.30872691309;36379.818100909855;37315.81342093272;37633.24733505314;37830.81084594559;38182;15847.445339413065;16018.279177437043;16188.75716864248;16207.270672819752;16210.513684589245;13395.464181432828;13592.728145437035;13699.315034248248;13701.862981370257;13704.45182192721;8270.627821748036;8363.665453381918;8391.538465384341;8595.140485951355;8620.482771033758;3599.7660152090552;3666.1934374437583;3667.064898450878;3675.191457879262;3677.687396571321;990.3265779270165;1022.320157095538;1048.816457120001;1143.056977993159;1162.645393155096;31236.375272494424;31375.37249255048;31583.526247105852;31874.043778686675;31884.88402905887;1155.5031336525208;1161.7502237019082;1212.1454374665839;1221.694576355911;1235.7713822942605;12918.741625167631;13984.370703318375;14868;15961.962472439487;16191.109488977983;653113;661958;664886;665073;670257;62549;64776.67611662006;65213;65379.67310163419;65587.01619475712;1233.0197492993093;1422.11118051218;1460.2771628044186;1559.1892216047593;1559.50095969291;30841.38317233598;30965.535516966815;30996;31497;31593.21016974594;55412;55520.88958220894;56699;57378.7131064342;57551.848963021344;506209;508255;508557;508818.4559077181;509620;27797.861010694818;28061.859690701414;28807;28898.422031559672;29271;46332.30501542547;48044;48831.511684882695;49032.597683796164;49271.26093108678;32869.34261314808;39947.60052399439;40032.1993560133;40150.79924600358;40420.595794041685;39284.410733839584;39472.802635986634;39640;40370.788876333754;40381;38439.231215376094;38693.61306387013;39360.6063939357;40399.19201615892;40474.1905161901;34708.65291347054;34880.30239395249;35294.47058294179;35420.82289588536;35533;26413.60379594346;26610.600840987787;26636;26684.599731003662;26912.92348306046 04:43:02 INFO - PROCESS | 1666 | |2;jquery.html;311.54981052379304;417.47815230961305;417.65752083291676;422.66398213420337;425.6679789763985;15913;20453.693194602074;21142.89428552855;21185.046672899716;21417.9291035448;19423.028848557587;19776;19889.40331790045;20915.267965621206;20916.477088072807;5898.852528686774;5926.3184733755525;6021.9698901505435;6068.3021452533085;6186.041163619646;6003.639781613096;6050.304215015286;6137.877242455148;6148.6310821350635;6154.84612884677;5775.768969241225;6015.6992150392525;6052.273727152748;6079.817605471843;6124.5100391968535;5765.884682306372;5990.221271234734;5994.820155395345;6028.517718582503;6031.547633927451;5104.923426148611;5835.766569337221;5988.981873081587;6041.335453100155;6047.969760151171;11977.92198702121;13198.53805116826;13317.733645327136;13501.86498135016;13764;2151.268568686654;2175.8368122390884;2279.578278018572;2292.4383526036063;2358.3160883343808;10065.094141527297;10443.955604439496;10648.094911932494;11753.823692644617;15799.210039497979;1767.672980498599;1787.356551641408;1801.882877612951;1866.617343444604;1881;84852;125103.374483127;127432;127668;128902.06646900304;10694.839577406345;11297.604583839526;11770.94061534466;12004.039676825832;12024.819627705592;14919.477818276308;14958.177300248592;15177.317020734094;15402.614934626725;15463.458778942682;8437.325013998865;8872.467651940904;8876.51179185138;8892.555372231363;9181.954090229507;7371.115466144097;8625.913740862636;8739.912600874037;8740.257078148428;8771.122887711306;4710.88222794426;4750.596199323028;4764.8332308369045;4825.252085926687;4867.683600565952;1824.2429391802254;1906.1803424527586;2003.1486618187212;2077.10684405707;2117.322456813805;929;951.9048095190564;982.3614650477105;1082.5345101606385;1127.2560110327145;16038.518844434686;19454.90693654886;20457.2839950601;21299.82850943213;21568.676469852966;926.9073092690677;954.9952250238844;1031.8452232165234;1104.3484344236779;1109.2623405435295;11021;11216.943915280372;11382.886171138349;11383.260088094248;11421.942890285496;604865;622363;656471;665761;670176;110027;135746.321268395;140193.59806401806;142676;148902;990.5443495991924;1010.242318261304;1010.4291075542295;1025.190099821148;1027.845823126537;16914.915425422794;18253.81350212285;18275.45173644793;18768.906155469682;19010.85934843914;36243.81878090592;50895.98208035745;52436;53993.730031349594;57740;69146.30853691399;81143.5942820282;81460;83281.58359208165;84915.57542212249;9165;12170.026397888325;12619.179753316004;12869.35653217354;13023.609291721263;13708.93145534266;13722.519711810039;13841.653958651113;13896.23570703621;14025.228612426414;11255.718607034889;11391.54433822671;11594.594189203675;11772.293662380285;11942.820857686967;10057.346272492265;11643.825342619699;11646.068314534987;11913.106517011433;11981.940090299493;11603.883961160618;11636;11905;12158.93920530427;12309.015278777855;11877.940610296893;12100.213486123374;12553.058520610808;12815.743685126059;12941.288229147487;11067.944660276647;12144.757104857677;12162.93918530437;12346.691332716753;12395.690107747378 04:43:02 INFO - PROCESS | 1666 | |3;mootools.html;1621.2542230573936;1642.0968467342962;1786.205138713273;1895.2134864031427;1969.2713695932507;8311.085780564148;8842.336824738139;9094.90905090949;9305.953470232647;9313.58088886;7357.705691772323;8651.87022194666;8723.869141962876;8812.162844529776;8813.735587932373;2419.697537807774;2489.639002344659;2495.538325409805;2497.612870005152;2506.686664166979;2483.242611003643;2518.1312447205682;2554.3997160667227;2561.9487610247784;2569.0494517028724;2532.480511692979;2536.936576585582;2539.3270783242456;2540.9110681126162;2545.8217924745277;2526.5578523758454;2530.746925307473;2531.3798119460666;2539.2382285314425;2563.346346681594;2520.143151328539;2527.06498595519;2530.784883284923;2575.6136579513036;2581.664383630116;8826.735197944072;8910.643574257021;8929.464232146027;8937.285017198608;8956.731298061068;5675.006873797069;5682.6306290091015;5709.200711900296;5818.883622327572;5833.82498525045;3639.1266096137;3726.7391282609956;3732.048327676452;3768.8680896168776;3820.5033345665165;1054.4095306628312;1074.7689246811974;1081.0432767001182;1082.837574363844;1083.3987137138886;11986.460609272604;12012.219205751686;12134.817977730341;12536.561220357244;12595.24428534291;4972.65191436596;5001.149804533238;5048.3184770056305;5105.387353517602;5139.12634852076;10192.184625229964;10218.591256349811;10271;10398.740031499274;10543.31468454548;5483.369412517612;5510.889782204414;5539.612227144142;5549.139883318092;5652.689102099342;4654.743989080565;5025.919427323143;5052.797888084509;5121.180611102206;5153.072446959583;4091.0999580092334;4156.459660244149;4171.374293855885;4211.220924129046;4286.357046442996;1391.4503771010395;1408.704172123845;1419.4889839657715;1421.403010735473;1429.8784603308627;957.2676902169845;969.1132613658424;976.8827740671165;979.2704435195682;986.1322036607739;6050.54620903434;6065.120557519135;6089.756409743561;6153.446189842935;6169.321374648785;471.82542459290283;473.26643702262044;478.4927976345085;482.79722516543137;488.53833127693986;3956.228535435562;4063.349864021742;4100.0774825664585;4121.8969525762095;4206.26390381682;10771.353718776898;10876.945615271872;10896.237263391646;11051.502682379312;11065.004149626573;10862.34825910448;10884.510197041152;10989.395583242998;10990.17573681977;11008.339499629888;8278.668853245803;8551.931008623922;8602.913970860336;8614.698485552975;8680.175383338572;4959.876003099951;5831.7667293307795;5842.503387212135;5847.327557330791;6074.149619053248;9810.509474526103;9811.166050885755;9886.950565247127;9921.801563968536;10031.749206269902;8896.887889013873;9475.620975160917;9834.75413114678;10308.896911030793;10507.211959103252;6638.269790323157;7008.859822803413;7780.299773020455;8281;8336.916630833613;7142;8327.95900512436;8361.16388361159;8380.958095209486;8386.748397547839;7461.328480436787;7567.394608431202;7591.240875912365;7606.543607383574;7706.499077559941;6847.828804279933;7400.962995184989;7433.92566074354;7458;7551.056117985252;7244.601546914971;7271.200167981624;7313.670884810303;7338.449616278694;7364.3372096511575;4945.109880221595;4946.826861059845;4985.800567977385;5033.169527028;5058.241263810458;5087.64386492942;5089.618278629192;5091.745412729423;5164.509371609691;5343.438938911514 04:43:02 INFO - PROCESS | 1666 | |4;prototype.html;334.38139442032235;335.86689575506955;336.39784785234446;343.34249911419624;346.1001396369438;5622.746976386063;6873.587584744906;6950;7085.504014718972;7087.865941449362;6854.314568543143;6976.860462790741;6978.092847929762;7010.193827709815;7023.403010744093;4832.8884356598;5162.793488260465;5239.292695486118;5242.1088414969545;5301.1253143231515;4288.335308027261;5269.23480633988;5275.103232450492;5279.472052794728;5301.761420736057;5206.427292997767;5215.139501982168;5221.895562088775;5223.138182199951;5226.163813789794;4498.212812757754;4758.738269395182;4967.279744437054;5221.269022336875;5225.294585230983;3259.951100733491;3595.9101022474388;3796.2597293527774;4399.054203346264;4425.468943726773;6646.401823835829;6669.43309818666;6687.264400915896;6692.531522793406;6696.096027036337;6050.667213303266;6058.182145410357;6061.212042434456;6063.363346848606;6081.513478921675;7455.2107494201;7471.476996610239;7473.439492038119;7487.66305516253;7507.2117427669855;4833.806647734086;4996.150654388763;5000.474950130257;5001.424836143854;5011.373578302712;5926.348101708809;7984.121746607869;8005.719799807037;8032.759017229492;8042.919570804275;5101.2603172539775;5116.386033675908;5134.717590532482;5140.126178549581;5152.3044389007755;5254.579633629377;5255.106631872591;5260.421353651095;5265.973670131625;5273;6083.726232319556;6093.878122437526;6094.074844074868;6107.144999700045;6114;7307.561546307238;7608.201138880338;7627.847443051108;7634.961825190839;7691.807704807425;1465.2893346726828;1783.2064731194494;1808.1501694203703;1836.6326734652855;1839.1815642039164;1085.7557049663762;1149.7010777197988;1158.7856246594406;1164.6098556983336;1187.305426325592;6137.539684523678;6674.466042716571;7033.824154396181;7046.647667616701;7054.92945070553;7641.235876412426;7735.226477352332;7786.026746656668;7806.297433231037;7826.295633393022;5633;7054.506184567031;7061.470389720792;7084.716611335489;7116.822079447952;3266.575345205108;3381.425157723193;4000.6199411055904;4103.753774773523;4147.336426171798;5661.745221465044;8185.5088694677315;8187.959060204661;8237.011558613005;8269.793255168668;6438;6679.398854103154;8108.878366824502;8155.388345874083;8205.097439281673;8234.547099909563;8253.298469630028;8268.503889766633;8426.368022398467;8435.072142064246;7710.498817576839;7944.960275198587;7954.960225198837;7994.84010319802;8009.799755005938;6589.604623722592;7814.921850781419;7834.0990786058055;7850.371970242252;7870.527768333918;8249.79375515617;8251.917480825356;8262;8262.256396924306;8297.419180657296;4907.950920490749;4953.900921981613;4961.479044700399;4967.230079337708;4984.800607975641;6341.417099338859;7571.3942884568005;7853.253940875607;7873;7937.6031198438695;5918.112283157561;6515.185601799775;7327.74352897646;7636.350910172475;7654.119776225805;6430.778152151076;7362.889556656547;7652.426068045031;7671.424643151674;7675.577843218453;7224.662574851775;7383.966244725635;7406.18531961473;7454.515456495527;7501.024866767285;7559.962200188964;7602.847943041219;7630.809229769078;7633.1985141559335;7675.232476752503;7207.819804504929;7211.783646490614;7323.450741194538;7354.558726476428;7378.335949764547 04:43:02 INFO - PROCESS | 1666 | |5;yui.html;661.2659947458324;704.3449591879552;721.2174790352467;788.8501184774892;796.0288448093328;15381.615459613515;15517.844821551782;15549.300281487333;15679.059256444607;15819.525414237576;14306.713865722679;14624.049436786601;14642.633934151652;14646.34091465884;14656.706865862703;789.6170357376668;955.0401846144632;958.6548842416724;967.4969016111618;985.7781999050192;939.2532936315646;961.8557216417523;975.6633961283346;979.1774909076374;980.632262901412;1020.4999550220413;1030.4332617060625;1034.9702046463779;1035.9689209323733;1036.8600238967717;998.4059484606647;1010.9443980581065;1016.5628779624758;1019.7858449725567;1029.3360782295451;737.959412232327;741.3698356397073;745.7464462082863;766.6013672890122;767.54331172952;12431.62705118848;14622.049566778125;14800.40798368064;15060.021098628664;15142.621434464116;13358.799618005738;13386.732265354736;13387.799183012263;13502.257375844325;13522.526711565146;10047.447390393525;10333.431661258628;10363.896361036368;10453.63412280574;10666.520006599721;3507.8947631571095;3593.443016332473;3667.9816600917093;3717.962820371789;3877.0695033192114;66859.66570167166;83924;85172.57413712954;85745.14254857434;86237;9758.951205243928;9796.412215266964;9904.15814655748;9954.751131221778;10098.697039088838;22329.44176395603;22955;22990.425239368815;22994.655080173812;23343;7518.511296765692;7754.6898124074405;7782.143964163937;7787.46947116576;7988.960055199686;4146.5853414658895;4165.541790403053;4212.957870421318;4230.450041494586;4308.267594508941;3728.4034554471154;3764.7552909060823;3807.638274363931;3840.1935593525673;3852.768833869977;624.5784095735361;671.5467059734757;686.3102581905254;694.1531331775226;694.6630884021246;551.8206582860587;556.6854727079187;568.3293713418124;588.7027051339046;608.4675908579992;8233.876491852627;8417.494950303002;8424.831503369898;8492.363072769567;8514.616842242114;515.7601715202449;532.374460009495;576.5272476569173;604.2386592892987;610.4079043327964;3792.60177681345;3959.6634286086005;3959.9010024749036;3971.8808435746973;4156;66423;84914.15085849186;87821.56089219514;88743.78140546539;89270;71063.2893671067;72662.63668681623;73350;73612.52774944471;73914.6304268486;70622.29377706157;72261.91607125898;73345.69944352517;73393;73400;7780.49426787257;7997.080335761462;7997.560134192675;8028.59857007159;8198.098209196864;44096.45662401801;45881.85295367509;51294;51547.71130721612;51637.7418112922;66297.66851165713;68610.65694671495;71549.28450715427;71737.28262717306;72032.27967720256;10479.476026198507;10568.841467377842;10588.947055264674;10625.574977000833;10626.574937002433;10597.523111460157;10957.671269861918;10979.28634638746;10995.230333876552;11668.766624667289;10303.3817970922;10530.789384212427;10546.8417973732;10581.523831427758;10865.348079115278;10297.227707921786;10301.278910476194;10465.058144767008;10645.361278323326;11036.944815275872;9856.85214721794;10171.898281017095;10701.678949631523;11273.267237629529;11505.769884602429;9109.498977556033;9523.857142143012;9539.09378609031;9679.806403872024;9860.901390985999;9230.861537077084;9738.123568878835;9804.509774511103;9903.55434005457;9971.900280997388 04:43:02 INFO - PROCESS | 1666 | __end_tp_report 04:43:02 INFO - PROCESS | 1666 | __start_cc_report 04:43:02 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,396 04:43:02 INFO - PROCESS | 1666 | __end_cc_report 04:43:02 INFO - PROCESS | 1666 | __startTimestamp1468842182457__endTimestamp 04:43:02 INFO - PROCESS | 1666 | 04:43:02 INFO - PROCESS | 1666 | ------- Summary: start ------- 04:43:02 INFO - PROCESS | 1666 | Number of tests: 6 04:43:02 INFO - PROCESS | 1666 | 04:43:02 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5871.12 Median:6167.51 stddev:640.02 (10.4%) stddev-sans-first:616.98 04:43:02 INFO - PROCESS | 1666 | Values: 3613.2 3663.4 3663.7 3693.6 3708.7 5848.8 5864.6 5903.7 5933.2 5943.2 5879.5 5925.4 5937.9 5941.1 5944.7 5333.5 5345.4 5366.0 5380.2 5434.6 5342.1 5387.5 5407.8 5423.8 5518.9 5414.3 5431.7 5455.7 5499.9 5540.1 5475.2 5481.6 5504.2 5504.8 5506.4 5309.5 5366.2 5408.5 5414.7 5492.6 4498.8 4836.0 5745.5 5777.5 5976.6 6205.8 6231.4 6232.7 6233.6 6240.3 6276.3 6278.4 6283.9 6302.2 6308.9 5979.9 6073.0 6116.3 6167.5 6168.2 6521.6 6521.9 6541.3 6548.0 6554.6 6190.0 6247.6 6256.5 6257.5 6262.6 6278.2 6348.6 6358.1 6371.9 6372.0 6255.3 6256.8 6263.9 6281.7 6284.7 6171.2 6219.0 6229.6 6284.6 6291.5 5019.9 5122.9 5130.7 5139.8 5144.6 4576.1 4627.8 4628.0 4645.0 4649.3 4524.6 5146.0 5525.2 5661.9 6056.5 5983.8 6070.7 6382.7 6404.1 6414.2 6097.5 6139.7 6141.6 6157.4 6177.3 4783.7 5508.6 5577.8 5637.4 5667.5 6584.8 6588.7 6599.3 6614.2 6618.9 5414.9 6010.0 6381.9 6403.8 6415.1 6462.8 6526.9 6541.7 6644.9 6652.0 5262.8 6240.7 6242.5 6277.3 6281.3 6271.3 6331.9 6399.4 6407.8 6420.4 6124.0 6143.8 6186.7 6188.2 6229.7 5193.5 6230.9 6238.4 6240.2 6251.1 5905.5 6190.1 6222.4 6253.4 6263.9 6150.8 6199.4 6235.9 6237.8 6272.7 6188.1 6218.1 6232.8 6242.9 6243.9 04:43:02 INFO - PROCESS | 1666 | 04:43:02 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:67861.49 Median:39989.90 stddev:148028.69 (370.2%) stddev-sans-first:148357.64 04:43:02 INFO - PROCESS | 1666 | Values: 534.6 554.4 561.1 603.9 609.4 39820.8 40661.4 41269.0 41343.6 41366.4 44314.6 44722.8 45241.8 45419.8 45700.8 9658.8 9737.1 9779.6 9896.3 9924.0 9781.8 9781.9 9819.9 9906.4 9909.6 9759.9 9809.1 9862.5 9918.0 9959.3 9817.4 9821.9 9869.7 9904.0 9936.4 9772.8 9788.7 9876.0 9907.0 9923.7 40823.6 41004.0 41151.0 41323.0 41488.6 3348.0 3506.8 3541.6 3883.9 3896.1 27998.6 28727.6 28760.7 28916.0 29223.9 2787.8 2798.5 2823.4 2865.0 2912.5 467151.0 470304.0 470441.0 470747.0 474281.6 38042.0 38530.8 38678.6 68149.7 69127.3 36379.8 37315.8 37633.2 37830.8 38182.0 15847.4 16018.3 16188.8 16207.3 16210.5 13395.5 13592.7 13699.3 13701.9 13704.5 8270.6 8363.7 8391.5 8595.1 8620.5 3599.8 3666.2 3667.1 3675.2 3677.7 990.3 1022.3 1048.8 1143.1 1162.6 31236.4 31375.4 31583.5 31874.0 31884.9 1155.5 1161.8 1212.1 1221.7 1235.8 12918.7 13984.4 14868.0 15962.0 16191.1 653113.0 661958.0 664886.0 665073.0 670257.0 62549.0 64776.7 65213.0 65379.7 65587.0 1233.0 1422.1 1460.3 1559.2 1559.5 30841.4 30965.5 30996.0 31497.0 31593.2 55412.0 55520.9 56699.0 57378.7 57551.8 506209.0 508255.0 508557.0 508818.5 509620.0 27797.9 28061.9 28807.0 28898.4 29271.0 46332.3 48044.0 48831.5 49032.6 49271.3 32869.3 39947.6 40032.2 40150.8 40420.6 39284.4 39472.8 39640.0 40370.8 40381.0 38439.2 38693.6 39360.6 40399.2 40474.2 34708.7 34880.3 35294.5 35420.8 35533.0 26413.6 26610.6 26636.0 26684.6 26912.9 04:43:02 INFO - PROCESS | 1666 | 04:43:02 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:36565.52 Median:10664.60 stddev:107392.55 (1007.0%) stddev-sans-first:107659.31 04:43:02 INFO - PROCESS | 1666 | Values: 311.5 417.5 417.7 422.7 425.7 15913.0 20453.7 21142.9 21185.0 21417.9 19423.0 19776.0 19889.4 20915.3 20916.5 5898.9 5926.3 6022.0 6068.3 6186.0 6003.6 6050.3 6137.9 6148.6 6154.8 5775.8 6015.7 6052.3 6079.8 6124.5 5765.9 5990.2 5994.8 6028.5 6031.5 5104.9 5835.8 5989.0 6041.3 6048.0 11977.9 13198.5 13317.7 13501.9 13764.0 2151.3 2175.8 2279.6 2292.4 2358.3 10065.1 10444.0 10648.1 11753.8 15799.2 1767.7 1787.4 1801.9 1866.6 1881.0 84852.0 125103.4 127432.0 127668.0 128902.1 10694.8 11297.6 11770.9 12004.0 12024.8 14919.5 14958.2 15177.3 15402.6 15463.5 8437.3 8872.5 8876.5 8892.6 9182.0 7371.1 8625.9 8739.9 8740.3 8771.1 4710.9 4750.6 4764.8 4825.3 4867.7 1824.2 1906.2 2003.1 2077.1 2117.3 929.0 951.9 982.4 1082.5 1127.3 16038.5 19454.9 20457.3 21299.8 21568.7 926.9 955.0 1031.8 1104.3 1109.3 11021.0 11216.9 11382.9 11383.3 11421.9 604865.0 622363.0 656471.0 665761.0 670176.0 110027.0 135746.3 140193.6 142676.0 148902.0 990.5 1010.2 1010.4 1025.2 1027.8 16914.9 18253.8 18275.5 18768.9 19010.9 36243.8 50896.0 52436.0 53993.7 57740.0 69146.3 81143.6 81460.0 83281.6 84915.6 9165.0 12170.0 12619.2 12869.4 13023.6 13708.9 13722.5 13841.7 13896.2 14025.2 11255.7 11391.5 11594.6 11772.3 11942.8 10057.3 11643.8 11646.1 11913.1 11981.9 11603.9 11636.0 11905.0 12158.9 12309.0 11877.9 12100.2 12553.1 12815.7 12941.3 11067.9 12144.8 12162.9 12346.7 12395.7 04:43:02 INFO - PROCESS | 1666 | 04:43:02 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5853.01 Median:5029.54 stddev:3238.72 (64.4%) stddev-sans-first:3232.19 04:43:02 INFO - PROCESS | 1666 | Values: 1621.3 1642.1 1786.2 1895.2 1969.3 8311.1 8842.3 9094.9 9306.0 9313.6 7357.7 8651.9 8723.9 8812.2 8813.7 2419.7 2489.6 2495.5 2497.6 2506.7 2483.2 2518.1 2554.4 2561.9 2569.0 2532.5 2536.9 2539.3 2540.9 2545.8 2526.6 2530.7 2531.4 2539.2 2563.3 2520.1 2527.1 2530.8 2575.6 2581.7 8826.7 8910.6 8929.5 8937.3 8956.7 5675.0 5682.6 5709.2 5818.9 5833.8 3639.1 3726.7 3732.0 3768.9 3820.5 1054.4 1074.8 1081.0 1082.8 1083.4 11986.5 12012.2 12134.8 12536.6 12595.2 4972.7 5001.1 5048.3 5105.4 5139.1 10192.2 10218.6 10271.0 10398.7 10543.3 5483.4 5510.9 5539.6 5549.1 5652.7 4654.7 5025.9 5052.8 5121.2 5153.1 4091.1 4156.5 4171.4 4211.2 4286.4 1391.5 1408.7 1419.5 1421.4 1429.9 957.3 969.1 976.9 979.3 986.1 6050.5 6065.1 6089.8 6153.4 6169.3 471.8 473.3 478.5 482.8 488.5 3956.2 4063.3 4100.1 4121.9 4206.3 10771.4 10876.9 10896.2 11051.5 11065.0 10862.3 10884.5 10989.4 10990.2 11008.3 8278.7 8551.9 8602.9 8614.7 8680.2 4959.9 5831.8 5842.5 5847.3 6074.1 9810.5 9811.2 9887.0 9921.8 10031.7 8896.9 9475.6 9834.8 10308.9 10507.2 6638.3 7008.9 7780.3 8281.0 8336.9 7142.0 8328.0 8361.2 8381.0 8386.7 7461.3 7567.4 7591.2 7606.5 7706.5 6847.8 7401.0 7433.9 7458.0 7551.1 7244.6 7271.2 7313.7 7338.4 7364.3 4945.1 4946.8 4985.8 5033.2 5058.2 5087.6 5089.6 5091.7 5164.5 5343.4 04:43:02 INFO - PROCESS | 1666 | 04:43:02 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:6101.70 Median:6689.90 stddev:1987.76 (29.7%) stddev-sans-first:1945.63 04:43:02 INFO - PROCESS | 1666 | Values: 334.4 335.9 336.4 343.3 346.1 5622.7 6873.6 6950.0 7085.5 7087.9 6854.3 6976.9 6978.1 7010.2 7023.4 4832.9 5162.8 5239.3 5242.1 5301.1 4288.3 5269.2 5275.1 5279.5 5301.8 5206.4 5215.1 5221.9 5223.1 5226.2 4498.2 4758.7 4967.3 5221.3 5225.3 3260.0 3595.9 3796.3 4399.1 4425.5 6646.4 6669.4 6687.3 6692.5 6696.1 6050.7 6058.2 6061.2 6063.4 6081.5 7455.2 7471.5 7473.4 7487.7 7507.2 4833.8 4996.2 5000.5 5001.4 5011.4 5926.3 7984.1 8005.7 8032.8 8042.9 5101.3 5116.4 5134.7 5140.1 5152.3 5254.6 5255.1 5260.4 5266.0 5273.0 6083.7 6093.9 6094.1 6107.1 6114.0 7307.6 7608.2 7627.8 7635.0 7691.8 1465.3 1783.2 1808.2 1836.6 1839.2 1085.8 1149.7 1158.8 1164.6 1187.3 6137.5 6674.5 7033.8 7046.6 7054.9 7641.2 7735.2 7786.0 7806.3 7826.3 5633.0 7054.5 7061.5 7084.7 7116.8 3266.6 3381.4 4000.6 4103.8 4147.3 5661.7 8185.5 8188.0 8237.0 8269.8 6438.0 6679.4 8108.9 8155.4 8205.1 8234.5 8253.3 8268.5 8426.4 8435.1 7710.5 7945.0 7955.0 7994.8 8009.8 6589.6 7814.9 7834.1 7850.4 7870.5 8249.8 8251.9 8262.0 8262.3 8297.4 4908.0 4953.9 4961.5 4967.2 4984.8 6341.4 7571.4 7853.3 7873.0 7937.6 5918.1 6515.2 7327.7 7636.4 7654.1 6430.8 7362.9 7652.4 7671.4 7675.6 7224.7 7384.0 7406.2 7454.5 7501.0 7560.0 7602.8 7630.8 7633.2 7675.2 7207.8 7211.8 7323.5 7354.6 7378.3 04:43:02 INFO - PROCESS | 1666 | 04:43:02 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18068.92 Median:542.10 stddev:25066.11 (4623.9%) stddev-sans-first:25102.35 04:43:02 INFO - PROCESS | 1666 | Values: 661.3 704.3 721.2 788.9 796.0 15381.6 15517.8 15549.3 15679.1 15819.5 14306.7 14624.0 14642.6 14646.3 14656.7 789.6 955.0 958.7 967.5 985.8 939.3 961.9 975.7 979.2 980.6 1020.5 1030.4 1035.0 1036.0 1036.9 998.4 1010.9 1016.6 1019.8 1029.3 738.0 741.4 745.7 766.6 767.5 12431.6 14622.0 14800.4 15060.0 15142.6 13358.8 13386.7 13387.8 13502.3 13522.5 10047.4 10333.4 10363.9 10453.6 10666.5 3507.9 3593.4 3668.0 3718.0 3877.1 66859.7 83924.0 85172.6 85745.1 86237.0 9759.0 9796.4 9904.2 9954.8 10098.7 22329.4 22955.0 22990.4 22994.7 23343.0 7518.5 7754.7 7782.1 7787.5 7989.0 4146.6 4165.5 4213.0 4230.5 4308.3 3728.4 3764.8 3807.6 3840.2 3852.8 624.6 671.5 686.3 694.2 694.7 551.8 556.7 568.3 588.7 608.5 8233.9 8417.5 8424.8 8492.4 8514.6 515.8 532.4 576.5 604.2 610.4 3792.6 3959.7 3959.9 3971.9 4156.0 66423.0 84914.2 87821.6 88743.8 89270.0 71063.3 72662.6 73350.0 73612.5 73914.6 70622.3 72261.9 73345.7 73393.0 73400.0 7780.5 7997.1 7997.6 8028.6 8198.1 44096.5 45881.9 51294.0 51547.7 51637.7 66297.7 68610.7 71549.3 71737.3 72032.3 10479.5 10568.8 10588.9 10625.6 10626.6 10597.5 10957.7 10979.3 10995.2 11668.8 10303.4 10530.8 10546.8 10581.5 10865.3 10297.2 10301.3 10465.1 10645.4 11036.9 9856.9 10171.9 10701.7 11273.3 11505.8 9109.5 9523.9 9539.1 9679.8 9860.9 9230.9 9738.1 9804.5 9903.6 9971.9 04:43:02 INFO - PROCESS | 1666 | -------- Summary: end -------- 04:43:02 INFO - PROCESS | 1666 | 04:43:02 INFO - TEST-INFO | 1666: exit 0 04:43:02 INFO - TEST-OK | dromaeo_css | took 1109559ms 04:43:02 INFO - TEST-START | kraken 04:43:02 INFO - operating with platform_type : mac_ 04:43:02 INFO - Initialising browser for kraken test... 04:43:03 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmpUQSSvW/profile http://localhost:49275/getInfo.html) 04:43:05 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 04:43:05 INFO - PROCESS | 1679 | colorDepth:24 04:43:05 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 04:43:05 INFO - PROCESS | 1679 | __metrics 04:43:05 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:43:06 INFO - TEST-INFO | 1679: exit 0 04:43:06 INFO - Browser initialized. 04:43:06 INFO - Running cycle 1/1 for kraken test... 04:43:06 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmpUQSSvW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:18 INFO - PROCESS | 1683 | RSS: Main: 170971136 04:43:18 INFO - PROCESS | 1683 | 04:43:20 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 04:43:21 INFO - PROCESS | 1683 | RSS: Main: 183513088 04:43:21 INFO - PROCESS | 1683 | 04:43:24 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 04:43:25 INFO - PROCESS | 1683 | RSS: Main: 192147456 04:43:25 INFO - PROCESS | 1683 | 04:43:28 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 04:43:28 INFO - PROCESS | 1683 | RSS: Main: 195653632 04:43:28 INFO - PROCESS | 1683 | 04:43:30 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 04:43:31 INFO - PROCESS | 1683 | RSS: Main: 196993024 04:43:31 INFO - PROCESS | 1683 | 04:43:33 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:34 INFO - PROCESS | 1683 | RSS: Main: 197545984 04:43:34 INFO - PROCESS | 1683 | 04:43:37 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:37 INFO - PROCESS | 1683 | RSS: Main: 198303744 04:43:37 INFO - PROCESS | 1683 | 04:43:40 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 04:43:41 INFO - PROCESS | 1683 | RSS: Main: 198033408 04:43:41 INFO - PROCESS | 1683 | 04:43:43 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 04:43:44 INFO - PROCESS | 1683 | RSS: Main: 198193152 04:43:44 INFO - PROCESS | 1683 | 04:43:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:43:46 INFO - PROCESS | 1683 | RSS: Main: 197517312 04:43:46 INFO - PROCESS | 1683 | 04:43:48 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:43:49 INFO - PROCESS | 1683 | RSS: Main: 197685248 04:43:49 INFO - PROCESS | 1683 | 04:43:51 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:43:52 INFO - PROCESS | 1683 | RSS: Main: 197898240 04:43:52 INFO - PROCESS | 1683 | 04:43:54 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:43:55 INFO - PROCESS | 1683 | RSS: Main: 197955584 04:43:55 INFO - PROCESS | 1683 | 04:43:58 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:43:59 INFO - PROCESS | 1683 | RSS: Main: 197890048 04:43:59 INFO - PROCESS | 1683 | 04:44:00 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 04:44:01 INFO - PROCESS | 1683 | RSS: Main: 199880704 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | __start_tp_report 04:44:01 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 04:44:01 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 04:44:01 INFO - PROCESS | 1683 | |i|pagename|runs| 04:44:01 INFO - PROCESS | 1683 | |0;ai-astar;115;110;116;116;117;131;115;114;116;116 04:44:01 INFO - PROCESS | 1683 | |1;audio-beat-detection;157;143;150;160;134;170;165;126;165;130 04:44:01 INFO - PROCESS | 1683 | |2;audio-dft;192;199;195;194;192;192;208;197;201;193 04:44:01 INFO - PROCESS | 1683 | |3;audio-fft;63;81;74;150;68;87;83;71;120;56 04:44:01 INFO - PROCESS | 1683 | |4;audio-oscillator;78;81;123;76;77;83;114;79;78;118 04:44:01 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;135;130;89;90;135;130;89;87;89;88 04:44:01 INFO - PROCESS | 1683 | |6;imaging-darkroom;96;96;96;114;153;93;96;95;95;95 04:44:01 INFO - PROCESS | 1683 | |7;imaging-desaturate;91;93;89;90;94;91;89;89;90;89 04:44:01 INFO - PROCESS | 1683 | |8;json-parse-financial;61;62;67;63;66;65;65;80;64;61 04:44:01 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;62;93;93;107;71;71;72;68;68;65 04:44:01 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;80;95;102;71;74;82;70;95;94;109 04:44:01 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;129;126;124;138;140;154;138;144;200;167 04:44:01 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;166;166;164;164;197;150;217;205;208;163 04:44:01 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;67;70;67;67;69;70;67;93;93;98 04:44:01 INFO - PROCESS | 1683 | __end_tp_report 04:44:01 INFO - PROCESS | 1683 | __start_cc_report 04:44:01 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1040 04:44:01 INFO - PROCESS | 1683 | __end_cc_report 04:44:01 INFO - PROCESS | 1683 | __startTimestamp1468842241112__endTimestamp 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | ------- Summary: start ------- 04:44:01 INFO - PROCESS | 1683 | Number of tests: 14 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:116.60 Median:116.00 stddev:5.42 (4.7%) stddev-sans-first:5.72 04:44:01 INFO - PROCESS | 1683 | Values: 115.0 110.0 116.0 116.0 117.0 131.0 115.0 114.0 116.0 116.0 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:158.50 stddev:15.92 (10.0%) stddev-sans-first:16.68 04:44:01 INFO - PROCESS | 1683 | Values: 157.0 143.0 150.0 160.0 134.0 170.0 165.0 126.0 165.0 130.0 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:196.30 Median:196.00 stddev:5.17 (2.6%) stddev-sans-first:5.24 04:44:01 INFO - PROCESS | 1683 | Values: 192.0 199.0 195.0 194.0 192.0 192.0 208.0 197.0 201.0 193.0 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:85.30 Median:72.50 stddev:28.68 (39.6%) stddev-sans-first:29.27 04:44:01 INFO - PROCESS | 1683 | Values: 63.0 81.0 74.0 150.0 68.0 87.0 83.0 71.0 120.0 56.0 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:78.00 stddev:19.29 (24.7%) stddev-sans-first:19.90 04:44:01 INFO - PROCESS | 1683 | Values: 78.0 81.0 123.0 76.0 77.0 83.0 114.0 79.0 78.0 118.0 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:106.20 Median:88.50 stddev:22.71 (25.7%) stddev-sans-first:21.56 04:44:01 INFO - PROCESS | 1683 | Values: 135.0 130.0 89.0 90.0 135.0 130.0 89.0 87.0 89.0 88.0 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:102.90 Median:95.50 stddev:18.59 (19.5%) stddev-sans-first:19.54 04:44:01 INFO - PROCESS | 1683 | Values: 96.0 96.0 96.0 114.0 153.0 93.0 96.0 95.0 95.0 95.0 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:90.50 Median:90.50 stddev:1.78 (2.0%) stddev-sans-first:1.88 04:44:01 INFO - PROCESS | 1683 | Values: 91.0 93.0 89.0 90.0 94.0 91.0 89.0 89.0 90.0 89.0 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.00 stddev:5.52 (8.5%) stddev-sans-first:5.62 04:44:01 INFO - PROCESS | 1683 | Values: 61.0 62.0 67.0 63.0 66.0 65.0 65.0 80.0 64.0 61.0 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:77.00 Median:71.00 stddev:15.06 (21.2%) stddev-sans-first:14.96 04:44:01 INFO - PROCESS | 1683 | Values: 62.0 93.0 93.0 107.0 71.0 71.0 72.0 68.0 68.0 65.0 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:81.00 stddev:13.64 (16.8%) stddev-sans-first:14.21 04:44:01 INFO - PROCESS | 1683 | Values: 80.0 95.0 102.0 71.0 74.0 82.0 70.0 95.0 94.0 109.0 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:142.00 stddev:23.00 (16.2%) stddev-sans-first:23.56 04:44:01 INFO - PROCESS | 1683 | Values: 129.0 126.0 124.0 138.0 140.0 154.0 138.0 144.0 200.0 167.0 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:181.50 stddev:23.94 (13.2%) stddev-sans-first:24.86 04:44:01 INFO - PROCESS | 1683 | Values: 166.0 166.0 164.0 164.0 197.0 150.0 217.0 205.0 208.0 163.0 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.10 Median:70.00 stddev:12.94 (18.5%) stddev-sans-first:13.30 04:44:01 INFO - PROCESS | 1683 | Values: 67.0 70.0 67.0 67.0 69.0 70.0 67.0 93.0 93.0 98.0 04:44:01 INFO - PROCESS | 1683 | -------- Summary: end -------- 04:44:01 INFO - PROCESS | 1683 | 04:44:01 INFO - TEST-INFO | 1683: exit 0 04:44:01 INFO - TEST-OK | kraken | took 58863ms 04:44:01 INFO - SUITE-END | took 1168s 04:44:02 INFO - Completed test suite (00:19:28) 04:44:02 INFO - javascript benchmark 04:44:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3613.2231570212407, 3663.4321680139556, 3663.6519530644587, 3693.630636936307, 3708.7218458615594, 5848.766049358021, 5864.618799778012, 5903.704814759261, 5933.22868027157, 5943.197668314781, 5879.52963762899, 5925.437083477073, 5937.85155371116, 5941.079132734422, 5944.673042982634, 5333.466653334654, 5345.4387289334545, 5366.034113859504, 5380.166074258496, 5434.619576629638, 5342.091844386464, 5387.4612538746005, 5407.810726624569, 5423.755930983115, 5518.944810551903, 5414.3232095988005, 5431.728413579305, 5455.672659640414, 5499.917501237464, 5540.058190107671, 5475.206095116206, 5481.588880833953, 5504.2294078829, 5504.752286147133, 5506.421825708283, 5309.52214300711, 5366.168243922199, 5408.540274076709, 5414.729263536808, 5492.615516913817, 4498.8425405110665, 4835.951640483585, 5745.454181852718, 5777.537796976232, 5976.641401515923, 6205.815393218062, 6231.408016238495, 6232.657203853786, 6233.563650544464, 6240.31356550779, 6276.309605943343, 6278.434940855345, 6283.874322513524, 6302.243730752293, 6308.905366419507, 5979.940200597982, 6073.0, 6116.335771508194, 6167.506599472032, 6168.19813424252, 6521.6413097279155, 6521.934780652227, 6541.313162118005, 6547.985062315349, 6554.639494827735, 6189.96905015472, 6247.5939063960695, 6256.5307601930035, 6257.530685198628, 6262.5616206866, 6278.183836101278, 6348.587341822859, 6358.078078678565, 6371.904421433682, 6372.044193371032, 6255.343188965184, 6256.7810126645345, 6263.874722505524, 6281.654509002049, 6284.717187726564, 6171.1668924694595, 6218.968905155445, 6229.626222426669, 6284.622922624657, 6291.5281353898645, 5019.899602007939, 5122.92315615266, 5130.717810520383, 5139.820106296336, 5144.6398752087, 4576.130535198302, 4627.791749371287, 4628.0, 4644.9767751161025, 4649.279361698942, 4524.615407690383, 5145.974270128625, 5525.226468294442, 5661.858453538694, 6056.515478761688, 5983.760649573968, 6070.694800617888, 6382.744690212432, 6404.135441715402, 6414.166158399472, 6097.542684298695, 6139.693015349215, 6141.6007959482495, 6157.384261573897, 6177.289611694623, 4783.689060211075, 5508.55931525477, 5577.832665020056, 5637.408072152447, 5667.546596272371, 6584.835379115465, 6588.7364505421165, 6599.340065993362, 6614.173228346457, 6618.900716489256, 5414.918776218438, 6009.978303688296, 6381.936180638134, 6403.775867844603, 6415.133956915756, 6462.773802916875, 6526.902096468461, 6541.672916354068, 6644.900326495203, 6652.0, 5262.842114736564, 6240.656763878031, 6242.500599951902, 6277.2781130170615, 6281.340459251713, 6271.3415091414745, 6331.873362532631, 6399.424051835357, 6407.839804004937, 6420.422162005442, 6124.0201567748945, 6143.757528501975, 6186.721597528032, 6188.226471691039, 6229.657368844576, 5193.454687257784, 6230.937690623035, 6238.407351301619, 6240.188775459162, 6251.124842521959, 5905.527557795452, 6190.133381326708, 6222.377762223741, 6253.437190652863, 6263.937360626335, 6150.846228844314, 6199.442050215503, 6235.937640623536, 6237.844053898689, 6272.655003974825, 6188.1027251049245, 6218.098375735583, 6232.844178895564, 6242.875142497215, 6243.937560624336], "value": 5834.939504604063, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.6257619666233, 554.4427850010738, 561.1330494386174, 603.879224155169, 609.3753902250193, 39820.80089599552, 40661.39007914876, 41269.0, 41343.586564134384, 41366.37950430742, 44314.556854431445, 44722.77638611811, 45241.773791130996, 45419.772901135446, 45700.77149614247, 9658.806823863537, 9737.074977877126, 9779.559919803625, 9896.307258491872, 9923.950380248125, 9781.804363912717, 9781.853272200922, 9819.901800982007, 9906.405615663083, 9909.603615855358, 9759.853602195974, 9809.117179453848, 9862.506874656274, 9917.950410247939, 9959.302848800588, 9817.410955342631, 9821.90178098217, 9869.654562090329, 9903.950480247624, 9936.354136981145, 9772.804543909153, 9788.706338809847, 9876.0, 9907.0, 9923.65267215644, 40823.59176408227, 41004.0, 41151.0, 41323.0, 41488.58511414877, 3348.0458069450333, 3506.8421921013614, 3541.557305336833, 3883.8834834954996, 3896.1428485733095, 27998.5800212997, 28727.569086463718, 28760.712392876012, 28916.0, 29223.853880730672, 2787.8048536602446, 2798.4822807780624, 2823.350629355239, 2864.957025644617, 2912.504874171396, 467151.0, 470304.0, 470441.0, 470747.0, 474281.62859185826, 38042.04894877595, 38530.80734596309, 38678.61321386806, 68149.65925170343, 69127.30872691309, 36379.818100909855, 37315.81342093272, 37633.24733505314, 37830.81084594559, 38182.0, 15847.445339413065, 16018.279177437043, 16188.75716864248, 16207.270672819752, 16210.513684589245, 13395.464181432828, 13592.728145437035, 13699.315034248248, 13701.862981370257, 13704.45182192721, 8270.627821748036, 8363.665453381918, 8391.538465384341, 8595.140485951355, 8620.482771033758, 3599.7660152090552, 3666.1934374437583, 3667.064898450878, 3675.191457879262, 3677.687396571321, 990.3265779270165, 1022.320157095538, 1048.816457120001, 1143.056977993159, 1162.645393155096, 31236.375272494424, 31375.37249255048, 31583.526247105852, 31874.043778686675, 31884.88402905887, 1155.5031336525208, 1161.7502237019082, 1212.1454374665839, 1221.694576355911, 1235.7713822942605, 12918.741625167631, 13984.370703318375, 14868.0, 15961.962472439487, 16191.109488977983, 653113.0, 661958.0, 664886.0, 665073.0, 670257.0, 62549.0, 64776.67611662006, 65213.0, 65379.67310163419, 65587.01619475712, 1233.0197492993093, 1422.11118051218, 1460.2771628044186, 1559.1892216047593, 1559.50095969291, 30841.38317233598, 30965.535516966815, 30996.0, 31497.0, 31593.21016974594, 55412.0, 55520.88958220894, 56699.0, 57378.7131064342, 57551.848963021344, 506209.0, 508255.0, 508557.0, 508818.4559077181, 509620.0, 27797.861010694818, 28061.859690701414, 28807.0, 28898.422031559672, 29271.0, 46332.30501542547, 48044.0, 48831.511684882695, 49032.597683796164, 49271.26093108678, 32869.34261314808, 39947.60052399439, 40032.1993560133, 40150.79924600358, 40420.595794041685, 39284.410733839584, 39472.802635986634, 39640.0, 40370.788876333754, 40381.0, 38439.231215376094, 38693.61306387013, 39360.6063939357, 40399.19201615892, 40474.1905161901, 34708.65291347054, 34880.30239395249, 35294.47058294179, 35420.82289588536, 35533.0, 26413.60379594346, 26610.600840987787, 26636.0, 26684.599731003662, 26912.92348306046], "value": 19296.491155712665, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.54981052379304, 417.47815230961305, 417.65752083291676, 422.66398213420337, 425.6679789763985, 15913.0, 20453.693194602074, 21142.89428552855, 21185.046672899716, 21417.9291035448, 19423.028848557587, 19776.0, 19889.40331790045, 20915.267965621206, 20916.477088072807, 5898.852528686774, 5926.3184733755525, 6021.9698901505435, 6068.3021452533085, 6186.041163619646, 6003.639781613096, 6050.304215015286, 6137.877242455148, 6148.6310821350635, 6154.84612884677, 5775.768969241225, 6015.6992150392525, 6052.273727152748, 6079.817605471843, 6124.5100391968535, 5765.884682306372, 5990.221271234734, 5994.820155395345, 6028.517718582503, 6031.547633927451, 5104.923426148611, 5835.766569337221, 5988.981873081587, 6041.335453100155, 6047.969760151171, 11977.92198702121, 13198.53805116826, 13317.733645327136, 13501.86498135016, 13764.0, 2151.268568686654, 2175.8368122390884, 2279.578278018572, 2292.4383526036063, 2358.3160883343808, 10065.094141527297, 10443.955604439496, 10648.094911932494, 11753.823692644617, 15799.210039497979, 1767.672980498599, 1787.356551641408, 1801.882877612951, 1866.617343444604, 1881.0, 84852.0, 125103.374483127, 127432.0, 127668.0, 128902.06646900304, 10694.839577406345, 11297.604583839526, 11770.94061534466, 12004.039676825832, 12024.819627705592, 14919.477818276308, 14958.177300248592, 15177.317020734094, 15402.614934626725, 15463.458778942682, 8437.325013998865, 8872.467651940904, 8876.51179185138, 8892.555372231363, 9181.954090229507, 7371.115466144097, 8625.913740862636, 8739.912600874037, 8740.257078148428, 8771.122887711306, 4710.88222794426, 4750.596199323028, 4764.8332308369045, 4825.252085926687, 4867.683600565952, 1824.2429391802254, 1906.1803424527586, 2003.1486618187212, 2077.10684405707, 2117.322456813805, 929.0, 951.9048095190564, 982.3614650477105, 1082.5345101606385, 1127.2560110327145, 16038.518844434686, 19454.90693654886, 20457.2839950601, 21299.82850943213, 21568.676469852966, 926.9073092690677, 954.9952250238844, 1031.8452232165234, 1104.3484344236779, 1109.2623405435295, 11021.0, 11216.943915280372, 11382.886171138349, 11383.260088094248, 11421.942890285496, 604865.0, 622363.0, 656471.0, 665761.0, 670176.0, 110027.0, 135746.321268395, 140193.59806401806, 142676.0, 148902.0, 990.5443495991924, 1010.242318261304, 1010.4291075542295, 1025.190099821148, 1027.845823126537, 16914.915425422794, 18253.81350212285, 18275.45173644793, 18768.906155469682, 19010.85934843914, 36243.81878090592, 50895.98208035745, 52436.0, 53993.730031349594, 57740.0, 69146.30853691399, 81143.5942820282, 81460.0, 83281.58359208165, 84915.57542212249, 9165.0, 12170.026397888325, 12619.179753316004, 12869.35653217354, 13023.609291721263, 13708.93145534266, 13722.519711810039, 13841.653958651113, 13896.23570703621, 14025.228612426414, 11255.718607034889, 11391.54433822671, 11594.594189203675, 11772.293662380285, 11942.820857686967, 10057.346272492265, 11643.825342619699, 11646.068314534987, 11913.106517011433, 11981.940090299493, 11603.883961160618, 11636.0, 11905.0, 12158.93920530427, 12309.015278777855, 11877.940610296893, 12100.213486123374, 12553.058520610808, 12815.743685126059, 12941.288229147487, 11067.944660276647, 12144.757104857677, 12162.93918530437, 12346.691332716753, 12395.690107747378], "value": 9895.822154786387, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1621.2542230573936, 1642.0968467342962, 1786.205138713273, 1895.2134864031427, 1969.2713695932507, 8311.085780564148, 8842.336824738139, 9094.90905090949, 9305.953470232647, 9313.58088886, 7357.705691772323, 8651.87022194666, 8723.869141962876, 8812.162844529776, 8813.735587932373, 2419.697537807774, 2489.639002344659, 2495.538325409805, 2497.612870005152, 2506.686664166979, 2483.242611003643, 2518.1312447205682, 2554.3997160667227, 2561.9487610247784, 2569.0494517028724, 2532.480511692979, 2536.936576585582, 2539.3270783242456, 2540.9110681126162, 2545.8217924745277, 2526.5578523758454, 2530.746925307473, 2531.3798119460666, 2539.2382285314425, 2563.346346681594, 2520.143151328539, 2527.06498595519, 2530.784883284923, 2575.6136579513036, 2581.664383630116, 8826.735197944072, 8910.643574257021, 8929.464232146027, 8937.285017198608, 8956.731298061068, 5675.006873797069, 5682.6306290091015, 5709.200711900296, 5818.883622327572, 5833.82498525045, 3639.1266096137, 3726.7391282609956, 3732.048327676452, 3768.8680896168776, 3820.5033345665165, 1054.4095306628312, 1074.7689246811974, 1081.0432767001182, 1082.837574363844, 1083.3987137138886, 11986.460609272604, 12012.219205751686, 12134.817977730341, 12536.561220357244, 12595.24428534291, 4972.65191436596, 5001.149804533238, 5048.3184770056305, 5105.387353517602, 5139.12634852076, 10192.184625229964, 10218.591256349811, 10271.0, 10398.740031499274, 10543.31468454548, 5483.369412517612, 5510.889782204414, 5539.612227144142, 5549.139883318092, 5652.689102099342, 4654.743989080565, 5025.919427323143, 5052.797888084509, 5121.180611102206, 5153.072446959583, 4091.0999580092334, 4156.459660244149, 4171.374293855885, 4211.220924129046, 4286.357046442996, 1391.4503771010395, 1408.704172123845, 1419.4889839657715, 1421.403010735473, 1429.8784603308627, 957.2676902169845, 969.1132613658424, 976.8827740671165, 979.2704435195682, 986.1322036607739, 6050.54620903434, 6065.120557519135, 6089.756409743561, 6153.446189842935, 6169.321374648785, 471.82542459290283, 473.26643702262044, 478.4927976345085, 482.79722516543137, 488.53833127693986, 3956.228535435562, 4063.349864021742, 4100.0774825664585, 4121.8969525762095, 4206.26390381682, 10771.353718776898, 10876.945615271872, 10896.237263391646, 11051.502682379312, 11065.004149626573, 10862.34825910448, 10884.510197041152, 10989.395583242998, 10990.17573681977, 11008.339499629888, 8278.668853245803, 8551.931008623922, 8602.913970860336, 8614.698485552975, 8680.175383338572, 4959.876003099951, 5831.7667293307795, 5842.503387212135, 5847.327557330791, 6074.149619053248, 9810.509474526103, 9811.166050885755, 9886.950565247127, 9921.801563968536, 10031.749206269902, 8896.887889013873, 9475.620975160917, 9834.75413114678, 10308.896911030793, 10507.211959103252, 6638.269790323157, 7008.859822803413, 7780.299773020455, 8281.0, 8336.916630833613, 7142.0, 8327.95900512436, 8361.16388361159, 8380.958095209486, 8386.748397547839, 7461.328480436787, 7567.394608431202, 7591.240875912365, 7606.543607383574, 7706.499077559941, 6847.828804279933, 7400.962995184989, 7433.92566074354, 7458.0, 7551.056117985252, 7244.601546914971, 7271.200167981624, 7313.670884810303, 7338.449616278694, 7364.3372096511575, 4945.109880221595, 4946.826861059845, 4985.800567977385, 5033.169527028, 5058.241263810458, 5087.64386492942, 5089.618278629192, 5091.745412729423, 5164.509371609691, 5343.438938911514], "value": 4675.099224621082, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.38139442032235, 335.86689575506955, 336.39784785234446, 343.34249911419624, 346.1001396369438, 5622.746976386063, 6873.587584744906, 6950.0, 7085.504014718972, 7087.865941449362, 6854.314568543143, 6976.860462790741, 6978.092847929762, 7010.193827709815, 7023.403010744093, 4832.8884356598, 5162.793488260465, 5239.292695486118, 5242.1088414969545, 5301.1253143231515, 4288.335308027261, 5269.23480633988, 5275.103232450492, 5279.472052794728, 5301.761420736057, 5206.427292997767, 5215.139501982168, 5221.895562088775, 5223.138182199951, 5226.163813789794, 4498.212812757754, 4758.738269395182, 4967.279744437054, 5221.269022336875, 5225.294585230983, 3259.951100733491, 3595.9101022474388, 3796.2597293527774, 4399.054203346264, 4425.468943726773, 6646.401823835829, 6669.43309818666, 6687.264400915896, 6692.531522793406, 6696.096027036337, 6050.667213303266, 6058.182145410357, 6061.212042434456, 6063.363346848606, 6081.513478921675, 7455.2107494201, 7471.476996610239, 7473.439492038119, 7487.66305516253, 7507.2117427669855, 4833.806647734086, 4996.150654388763, 5000.474950130257, 5001.424836143854, 5011.373578302712, 5926.348101708809, 7984.121746607869, 8005.719799807037, 8032.759017229492, 8042.919570804275, 5101.2603172539775, 5116.386033675908, 5134.717590532482, 5140.126178549581, 5152.3044389007755, 5254.579633629377, 5255.106631872591, 5260.421353651095, 5265.973670131625, 5273.0, 6083.726232319556, 6093.878122437526, 6094.074844074868, 6107.144999700045, 6114.0, 7307.561546307238, 7608.201138880338, 7627.847443051108, 7634.961825190839, 7691.807704807425, 1465.2893346726828, 1783.2064731194494, 1808.1501694203703, 1836.6326734652855, 1839.1815642039164, 1085.7557049663762, 1149.7010777197988, 1158.7856246594406, 1164.6098556983336, 1187.305426325592, 6137.539684523678, 6674.466042716571, 7033.824154396181, 7046.647667616701, 7054.92945070553, 7641.235876412426, 7735.226477352332, 7786.026746656668, 7806.297433231037, 7826.295633393022, 5633.0, 7054.506184567031, 7061.470389720792, 7084.716611335489, 7116.822079447952, 3266.575345205108, 3381.425157723193, 4000.6199411055904, 4103.753774773523, 4147.336426171798, 5661.745221465044, 8185.5088694677315, 8187.959060204661, 8237.011558613005, 8269.793255168668, 6438.0, 6679.398854103154, 8108.878366824502, 8155.388345874083, 8205.097439281673, 8234.547099909563, 8253.298469630028, 8268.503889766633, 8426.368022398467, 8435.072142064246, 7710.498817576839, 7944.960275198587, 7954.960225198837, 7994.84010319802, 8009.799755005938, 6589.604623722592, 7814.921850781419, 7834.0990786058055, 7850.371970242252, 7870.527768333918, 8249.79375515617, 8251.917480825356, 8262.0, 8262.256396924306, 8297.419180657296, 4907.950920490749, 4953.900921981613, 4961.479044700399, 4967.230079337708, 4984.800607975641, 6341.417099338859, 7571.3942884568005, 7853.253940875607, 7873.0, 7937.6031198438695, 5918.112283157561, 6515.185601799775, 7327.74352897646, 7636.350910172475, 7654.119776225805, 6430.778152151076, 7362.889556656547, 7652.426068045031, 7671.424643151674, 7675.577843218453, 7224.662574851775, 7383.966244725635, 7406.18531961473, 7454.515456495527, 7501.024866767285, 7559.962200188964, 7602.847943041219, 7630.809229769078, 7633.1985141559335, 7675.232476752503, 7207.819804504929, 7211.783646490614, 7323.450741194538, 7354.558726476428, 7378.335949764547], "value": 5441.875445728237, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.2659947458324, 704.3449591879552, 721.2174790352467, 788.8501184774892, 796.0288448093328, 15381.615459613515, 15517.844821551782, 15549.300281487333, 15679.059256444607, 15819.525414237576, 14306.713865722679, 14624.049436786601, 14642.633934151652, 14646.34091465884, 14656.706865862703, 789.6170357376668, 955.0401846144632, 958.6548842416724, 967.4969016111618, 985.7781999050192, 939.2532936315646, 961.8557216417523, 975.6633961283346, 979.1774909076374, 980.632262901412, 1020.4999550220413, 1030.4332617060625, 1034.9702046463779, 1035.9689209323733, 1036.8600238967717, 998.4059484606647, 1010.9443980581065, 1016.5628779624758, 1019.7858449725567, 1029.3360782295451, 737.959412232327, 741.3698356397073, 745.7464462082863, 766.6013672890122, 767.54331172952, 12431.62705118848, 14622.049566778125, 14800.40798368064, 15060.021098628664, 15142.621434464116, 13358.799618005738, 13386.732265354736, 13387.799183012263, 13502.257375844325, 13522.526711565146, 10047.447390393525, 10333.431661258628, 10363.896361036368, 10453.63412280574, 10666.520006599721, 3507.8947631571095, 3593.443016332473, 3667.9816600917093, 3717.962820371789, 3877.0695033192114, 66859.66570167166, 83924.0, 85172.57413712954, 85745.14254857434, 86237.0, 9758.951205243928, 9796.412215266964, 9904.15814655748, 9954.751131221778, 10098.697039088838, 22329.44176395603, 22955.0, 22990.425239368815, 22994.655080173812, 23343.0, 7518.511296765692, 7754.6898124074405, 7782.143964163937, 7787.46947116576, 7988.960055199686, 4146.5853414658895, 4165.541790403053, 4212.957870421318, 4230.450041494586, 4308.267594508941, 3728.4034554471154, 3764.7552909060823, 3807.638274363931, 3840.1935593525673, 3852.768833869977, 624.5784095735361, 671.5467059734757, 686.3102581905254, 694.1531331775226, 694.6630884021246, 551.8206582860587, 556.6854727079187, 568.3293713418124, 588.7027051339046, 608.4675908579992, 8233.876491852627, 8417.494950303002, 8424.831503369898, 8492.363072769567, 8514.616842242114, 515.7601715202449, 532.374460009495, 576.5272476569173, 604.2386592892987, 610.4079043327964, 3792.60177681345, 3959.6634286086005, 3959.9010024749036, 3971.8808435746973, 4156.0, 66423.0, 84914.15085849186, 87821.56089219514, 88743.78140546539, 89270.0, 71063.2893671067, 72662.63668681623, 73350.0, 73612.52774944471, 73914.6304268486, 70622.29377706157, 72261.91607125898, 73345.69944352517, 73393.0, 73400.0, 7780.49426787257, 7997.080335761462, 7997.560134192675, 8028.59857007159, 8198.098209196864, 44096.45662401801, 45881.85295367509, 51294.0, 51547.71130721612, 51637.7418112922, 66297.66851165713, 68610.65694671495, 71549.28450715427, 71737.28262717306, 72032.27967720256, 10479.476026198507, 10568.841467377842, 10588.947055264674, 10625.574977000833, 10626.574937002433, 10597.523111460157, 10957.671269861918, 10979.28634638746, 10995.230333876552, 11668.766624667289, 10303.3817970922, 10530.789384212427, 10546.8417973732, 10581.523831427758, 10865.348079115278, 10297.227707921786, 10301.278910476194, 10465.058144767008, 10645.361278323326, 11036.944815275872, 9856.85214721794, 10171.898281017095, 10701.678949631523, 11273.267237629529, 11505.769884602429, 9109.498977556033, 9523.857142143012, 9539.09378609031, 9679.806403872024, 9860.901390985999, 9230.861537077084, 9738.123568878835, 9804.509774511103, 9903.55434005457, 9971.900280997388], "value": 6975.127287178788, "unit": "score"}], "name": "dromaeo_css", "value": 7632.768486545588, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 116.0, 116.0, 117.0, 131.0, 115.0, 114.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 143.0, 150.0, 160.0, 134.0, 170.0, 165.0, 126.0, 165.0, 130.0], "value": 150.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 199.0, 195.0, 194.0, 192.0, 192.0, 208.0, 197.0, 201.0, 193.0], "value": 196.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 81.0, 74.0, 150.0, 68.0, 87.0, 83.0, 71.0, 120.0, 56.0], "value": 85.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 123.0, 76.0, 77.0, 83.0, 114.0, 79.0, 78.0, 118.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 130.0, 89.0, 90.0, 135.0, 130.0, 89.0, 87.0, 89.0, 88.0], "value": 106.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 114.0, 153.0, 93.0, 96.0, 95.0, 95.0, 95.0], "value": 102.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 89.0, 90.0, 94.0, 91.0, 89.0, 89.0, 90.0, 89.0], "value": 90.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 67.0, 63.0, 66.0, 65.0, 65.0, 80.0, 64.0, 61.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 93.0, 93.0, 107.0, 71.0, 71.0, 72.0, 68.0, 68.0, 65.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 95.0, 102.0, 71.0, 74.0, 82.0, 70.0, 95.0, 94.0, 109.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 126.0, 124.0, 138.0, 140.0, 154.0, 138.0, 144.0, 200.0, 167.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 164.0, 164.0, 197.0, 150.0, 217.0, 205.0, 208.0, 163.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 67.0, 67.0, 69.0, 70.0, 67.0, 93.0, 93.0, 98.0], "value": 76.1, "unit": "score"}], "name": "kraken", "value": 1570.2, "alertThreshold": 2.0}]} 04:44:02 INFO - Return code: 0 04:44:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:44:02 ERROR - # TBPL SUCCESS # 04:44:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:44:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:44:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:44:02 INFO - 2016-07-18 04:44:02.390 screenresolution[1688:10524] starting screenresolution argv=screenresolution get 04:44:02 INFO - 2016-07-18 04:44:02.393 screenresolution[1688:10524] Display 0: 1600x1200x32@60 04:44:02 INFO - 2016-07-18 04:44:02.399 screenresolution[1689:10527] starting screenresolution argv=screenresolution list 04:44:02 INFO - Available Modes on Display 0 04:44:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:44:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:44:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:44:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:44:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:44:02 INFO - Intel Iris: 04:44:02 INFO - Chipset Model: Intel Iris 04:44:02 INFO - Type: GPU 04:44:02 INFO - Bus: Built-In 04:44:02 INFO - VRAM (Dynamic, Max): 1536 MB 04:44:02 INFO - Vendor: Intel (0x8086) 04:44:02 INFO - Device ID: 0x0a2e 04:44:02 INFO - Revision ID: 0x0009 04:44:02 INFO - Displays: 04:44:02 INFO - Display: 04:44:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:44:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:44:02 INFO - Display Serial Number: 1600x1200 60 04:44:02 INFO - Main Display: Yes 04:44:02 INFO - Mirror: Off 04:44:02 INFO - Online: Yes 04:44:02 INFO - Rotation: Supported 04:44:02 INFO - Return code: 0 04:44:02 INFO - Running post-action listener: _resource_record_post_action 04:44:02 INFO - Running post-run listener: _resource_record_post_run 04:44:03 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 36861440; Write bytes: 497493504; Read time: 245; Write time: 1562 04:44:03 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 189346304; Write bytes: 187561984; Read time: 17446; Write time: 422 04:44:03 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 34981376; Write bytes: 299138560; Read time: 224; Write time: 1103 04:44:03 INFO - Running post-run listener: _upload_blobber_files 04:44:03 INFO - Blob upload gear active. 04:44:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:44:03 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 04:44:03 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'] 04:44:03 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 04:44:04 INFO - (blobuploader) - INFO - Open directory for files ... 04:44:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:44:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:44:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:05 INFO - (blobuploader) - INFO - Done attempting. 04:44:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:44:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:44:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:06 INFO - (blobuploader) - INFO - Done attempting. 04:44:06 INFO - (blobuploader) - INFO - Iteration through files over. 04:44:06 INFO - Return code: 0 04:44:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:44:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:44:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f00b488f8fa5e3044eafa14db5eb3c49874f422e02ed361ba3c13176c8fd883b7b83dff5db64274c51a769502aefbeebd314d709b55f565afb843cc973fec24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0fdce16a33883197b2fa0f2ae1b5502f5239055280037754cd25cabb05c9058de2ca63683c08ed229338db17cd56a61e354c280c1e048e08ffdb0371de4f6e3a"} 04:44:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:44:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:44:06 INFO - Contents: 04:44:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f00b488f8fa5e3044eafa14db5eb3c49874f422e02ed361ba3c13176c8fd883b7b83dff5db64274c51a769502aefbeebd314d709b55f565afb843cc973fec24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0fdce16a33883197b2fa0f2ae1b5502f5239055280037754cd25cabb05c9058de2ca63683c08ed229338db17cd56a61e354c280c1e048e08ffdb0371de4f6e3a"} 04:44:06 INFO - Running post-run listener: copy_logs_to_upload_dir 04:44:06 INFO - Copying logs to upload dir... 04:44:06 INFO - mkdir: /builds/slave/test/build/upload/logs 04:44:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.433597 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-18 04:44:06.362220) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 04:44:06.369398) ========= 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.Hzzi0ovxvt/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.mhD0OrpdCH/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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/8f00b488f8fa5e3044eafa14db5eb3c49874f422e02ed361ba3c13176c8fd883b7b83dff5db64274c51a769502aefbeebd314d709b55f565afb843cc973fec24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0fdce16a33883197b2fa0f2ae1b5502f5239055280037754cd25cabb05c9058de2ca63683c08ed229338db17cd56a61e354c280c1e048e08ffdb0371de4f6e3a"} build_url:https://queue.taskcluster.net/v1/task/a2qSL45vSLu7hXYDr7nryQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011092 build_url: 'https://queue.taskcluster.net/v1/task/a2qSL45vSLu7hXYDr7nryQ/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/8f00b488f8fa5e3044eafa14db5eb3c49874f422e02ed361ba3c13176c8fd883b7b83dff5db64274c51a769502aefbeebd314d709b55f565afb843cc973fec24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0fdce16a33883197b2fa0f2ae1b5502f5239055280037754cd25cabb05c9058de2ca63683c08ed229338db17cd56a61e354c280c1e048e08ffdb0371de4f6e3a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 04:44:06.404504) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:44:06.404806) ========= 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.Hzzi0ovxvt/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.mhD0OrpdCH/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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.005050 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:44:06.453755) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 04:44:06.454126) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 04:44:06.454436) ========= ========= Total master_lag: 0.27 =========