builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0144 starttime: 1466699039.93 results: success (0) buildid: 20160623071724 builduid: b4235243ae4746cabd92af35cbf3230c revision: 2c5721ac42d71b2359320646afbdc7a919a60fd3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 09:23:59.928364) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 09:23:59.928868) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 09:23:59.929200) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 09:23:59.969293) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-06-23 09:23:59.969798) ========= 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.7NeIjTs2a7/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.6ljUllclmf/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-23 09:23:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.0M=0.001s 2016-06-23 09:24:00 (10.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104316 ========= master_lag: 3.38 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-06-23 09:24:03.456553) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:24:03.456940) ========= 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.7NeIjTs2a7/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.6ljUllclmf/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.029048 ========= master_lag: 0.72 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:24:04.206605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 09:24:04.207008) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2c5721ac42d71b2359320646afbdc7a919a60fd3 --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 2c5721ac42d71b2359320646afbdc7a919a60fd3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7NeIjTs2a7/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.6ljUllclmf/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-23 09:24:04,282 truncating revision to first 12 chars 2016-06-23 09:24:04,282 Setting DEBUG logging. 2016-06-23 09:24:04,282 attempt 1/10 2016-06-23 09:24:04,282 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2c5721ac42d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 09:24:05,329 unpacking tar archive at: mozilla-beta-2c5721ac42d7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.316148 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 09:24:05.545978) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 09:24:05.546368) ========= script_repo_revision: 2c5721ac42d71b2359320646afbdc7a919a60fd3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 09:24:05.546810) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 09:24:05.547141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 09:24:05.565211) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-23 09:24:05.565544) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7NeIjTs2a7/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.6ljUllclmf/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:05 INFO - MultiFileLogger online at 20160623 09:24:05 in /builds/slave/test 09:24:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:24:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:24:05 INFO - {'append_to_log': False, 09:24:05 INFO - 'base_work_dir': '/builds/slave/test', 09:24:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:24:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:24:05 INFO - 'branch': 'Mozilla-Beta', 09:24:05 INFO - 'buildbot_json_path': 'buildprops.json', 09:24:05 INFO - 'config_files': ('talos/mac_config.py',), 09:24:05 INFO - 'default_actions': ('clobber', 09:24:05 INFO - 'read-buildbot-config', 09:24:05 INFO - 'download-and-extract', 09:24:05 INFO - 'populate-webroot', 09:24:05 INFO - 'create-virtualenv', 09:24:05 INFO - 'install', 09:24:05 INFO - 'run-tests'), 09:24:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:24:05 INFO - 'download_minidump_stackwalk': True, 09:24:05 INFO - 'download_symbols': 'ondemand', 09:24:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:24:05 INFO - 'tooltool.py': '/tools/tooltool.py', 09:24:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:24:05 INFO - '/tools/misc-python/virtualenv.py')}, 09:24:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:24:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:24:05 INFO - 'installer_path': 'installer.exe', 09:24:05 INFO - 'log_level': 'info', 09:24:05 INFO - 'log_name': 'talos', 09:24:05 INFO - 'log_to_console': True, 09:24:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:24:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:24:05 INFO - 'opt_config_files': (), 09:24:05 INFO - 'pip_index': False, 09:24:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:24:05 INFO - 'cmd': ('bash', 09:24:05 INFO - '-c', 09:24:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:24:05 INFO - 'enabled': True, 09:24:05 INFO - 'halt_on_failure': False, 09:24:05 INFO - 'name': 'check_screen_resolution'},), 09:24:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:24:05 INFO - 'cmd': ('bash', 09:24:05 INFO - '-c', 09:24:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:24:05 INFO - 'enabled': True, 09:24:05 INFO - 'halt_on_failure': False, 09:24:05 INFO - 'name': 'check_screen_resolution'},), 09:24:05 INFO - 'run_cmd_checks_enabled': True, 09:24:05 INFO - 'sps_profile': False, 09:24:05 INFO - 'sps_profile_interval': 0, 09:24:05 INFO - 'suite': 'dromaeojs', 09:24:05 INFO - 'system_bits': '32', 09:24:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:24:05 INFO - 'title': 't-yosemite-r7-0144', 09:24:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:24:05 INFO - 'use_talos_json': True, 09:24:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:24:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:24:05 INFO - 'work_dir': 'build'} 09:24:05 INFO - ##### 09:24:05 INFO - ##### Running clobber step. 09:24:05 INFO - ##### 09:24:05 INFO - Running pre-action listener: _resource_record_pre_action 09:24:05 INFO - Running main action method: clobber 09:24:05 INFO - rmtree: /builds/slave/test/build 09:24:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:24:07 INFO - Running post-action listener: _resource_record_post_action 09:24:07 INFO - ##### 09:24:07 INFO - ##### Running read-buildbot-config step. 09:24:07 INFO - ##### 09:24:07 INFO - Running pre-action listener: _resource_record_pre_action 09:24:07 INFO - Running main action method: read_buildbot_config 09:24:07 INFO - Using buildbot properties: 09:24:07 INFO - { 09:24:07 INFO - "project": "", 09:24:07 INFO - "product": "firefox", 09:24:07 INFO - "script_repo_revision": "production", 09:24:07 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:24:07 INFO - "repository": "", 09:24:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:24:07 INFO - "buildid": "20160623071724", 09:24:07 INFO - "pgo_build": "False", 09:24:07 INFO - "basedir": "/builds/slave/test", 09:24:07 INFO - "buildnumber": 39, 09:24:07 INFO - "slavename": "t-yosemite-r7-0144", 09:24:07 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:24:07 INFO - "platform": "yosemite_r7", 09:24:07 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:24:07 INFO - "branch": "mozilla-beta", 09:24:07 INFO - "repo_path": "releases/mozilla-beta", 09:24:07 INFO - "revision": "2c5721ac42d71b2359320646afbdc7a919a60fd3", 09:24:07 INFO - "stage_platform": "macosx64", 09:24:07 INFO - "builduid": "b4235243ae4746cabd92af35cbf3230c", 09:24:07 INFO - "slavebuilddir": "test" 09:24:07 INFO - } 09:24:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 09:24:07 INFO - Running post-action listener: _resource_record_post_action 09:24:07 INFO - ##### 09:24:07 INFO - ##### Running download-and-extract step. 09:24:07 INFO - ##### 09:24:07 INFO - Running pre-action listener: _resource_record_pre_action 09:24:07 INFO - Running main action method: download_and_extract 09:24:07 INFO - mkdir: /builds/slave/test/build/tests 09:24:07 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')]} 09:24:07 INFO - https://queue.taskcluster.net/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:24:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 09:24:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 09:24:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/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 09:24:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/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 09:24:08 INFO - Downloaded 1165 bytes. 09:24:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 09:24:08 INFO - Using the following test package requirements: 09:24:08 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:24:08 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:24:08 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 09:24:08 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:24:08 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 09:24:08 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:24:08 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:24:08 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 09:24:08 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:24:08 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:24:08 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 09:24:08 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:24:08 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 09:24:08 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:24:08 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 09:24:08 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:24:08 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 09:24:08 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 09:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:08 INFO - https://queue.taskcluster.net/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:24:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:24:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:24:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/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 09:24:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/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 09:24:10 INFO - Downloaded 18301209 bytes. 09:24:10 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'] 09:24:10 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 09:24:14 INFO - Return code: 0 09:24:14 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 09:24:14 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')]} 09:24:14 INFO - https://queue.taskcluster.net/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:24:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:24:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:24:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/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 09:24:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/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 09:24:15 INFO - Downloaded 18301209 bytes. 09:24:15 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'] 09:24:15 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 09:24:18 INFO - Return code: 0 09:24: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')]} 09:24:18 INFO - https://queue.taskcluster.net/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:24:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 09:24:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 09:24:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/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 09:24:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/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 09:24:19 INFO - Downloaded 10840145 bytes. 09:24:19 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'] 09:24:19 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 09:24:19 INFO - Return code: 0 09:24:19 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')]} 09:24:19 INFO - https://queue.taskcluster.net/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 09:24:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:24:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:24:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 09:24:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/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 09:24:22 INFO - Downloaded 86249808 bytes. 09:24:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:24:22 INFO - mkdir: /builds/slave/test/properties 09:24:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:24:22 INFO - Writing to file /builds/slave/test/properties/build_url 09:24:22 INFO - Contents: 09:24:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:24:23 INFO - Running post-action listener: _resource_record_post_action 09:24:23 INFO - Running post-action listener: set_extra_try_arguments 09:24:23 INFO - ##### 09:24:23 INFO - ##### Running populate-webroot step. 09:24:23 INFO - ##### 09:24:23 INFO - Running pre-action listener: _resource_record_pre_action 09:24:23 INFO - Running main action method: populate_webroot 09:24:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:24:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:24:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:24:23 INFO - '--tppagecycles', 09:24:23 INFO - '7'], 09:24:23 INFO - 'tests': ['tsvgm']}}, 09:24:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:24:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:24:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:24:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:24:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:24:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:24:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:23 INFO - 'talos_options': ['--disable-e10s'], 09:24:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:23 INFO - 'talos_options': ['--disable-e10s'], 09:24:23 INFO - 'tests': ['damp', 'tps']}, 09:24:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:23 INFO - 'tests': ['damp', 'tps']}, 09:24:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:24:23 INFO - 'tests': ['dromaeo_dom']}, 09:24:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:24:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:24:23 INFO - 'tests': ['a11yr', 09:24:23 INFO - 'ts_paint', 09:24:23 INFO - 'tpaint', 09:24:23 INFO - 'sessionrestore', 09:24:23 INFO - 'sessionrestore_no_auto_restore', 09:24:23 INFO - 'tabpaint']}, 09:24:23 INFO - 'other-e10s': {'tests': ['a11yr', 09:24:23 INFO - 'ts_paint', 09:24:23 INFO - 'tpaint', 09:24:23 INFO - 'sessionrestore', 09:24:23 INFO - 'sessionrestore_no_auto_restore', 09:24:23 INFO - 'tabpaint']}, 09:24:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:24:23 INFO - 'ts_paint', 09:24:23 INFO - 'tpaint', 09:24:23 INFO - 'sessionrestore', 09:24:23 INFO - 'sessionrestore_no_auto_restore', 09:24:23 INFO - 'tabpaint']}, 09:24:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:24:23 INFO - 'ts_paint', 09:24:23 INFO - 'tpaint', 09:24:23 INFO - 'sessionrestore', 09:24:23 INFO - 'sessionrestore_no_auto_restore', 09:24:23 INFO - 'tabpaint']}, 09:24:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:24:23 INFO - 'tests': ['a11yr', 09:24:23 INFO - 'ts_paint', 09:24:23 INFO - 'tpaint', 09:24:23 INFO - 'sessionrestore', 09:24:23 INFO - 'sessionrestore_no_auto_restore', 09:24:23 INFO - 'tabpaint']}, 09:24:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:24:23 INFO - 'tests': ['a11yr', 09:24:23 INFO - 'ts_paint', 09:24:23 INFO - 'tpaint', 09:24:23 INFO - 'sessionrestore', 09:24:23 INFO - 'sessionrestore_no_auto_restore', 09:24:23 INFO - 'tabpaint']}, 09:24:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:24:23 INFO - 'tests': ['tsvgx', 09:24:23 INFO - 'tsvgr_opacity', 09:24:23 INFO - 'tart', 09:24:23 INFO - 'tscrollx', 09:24:23 INFO - 'cart']}, 09:24:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:24:23 INFO - 'tsvgr_opacity', 09:24:23 INFO - 'tart', 09:24:23 INFO - 'tscrollx', 09:24:23 INFO - 'cart']}, 09:24:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:23 INFO - 'talos_options': ['--disable-e10s'], 09:24:23 INFO - 'tests': ['tp5o']}, 09:24:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:23 INFO - 'tests': ['tp5o']}, 09:24:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:23 INFO - 'talos_options': ['--disable-e10s', 09:24:23 INFO - '--xperf_path', 09:24:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:23 INFO - 'tests': ['tp5n']}, 09:24:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:23 INFO - 'talos_options': ['--xperf_path', 09:24:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:23 INFO - 'tests': ['tp5n']}}, 09:24:23 INFO - 'talos.zip': {'path': '', 09:24:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:24:23 INFO - Running post-action listener: _resource_record_post_action 09:24:23 INFO - ##### 09:24:23 INFO - ##### Running create-virtualenv step. 09:24:23 INFO - ##### 09:24:23 INFO - Running pre-action listener: _resource_record_pre_action 09:24:23 INFO - Running main action method: create_virtualenv 09:24:23 INFO - Creating virtualenv /builds/slave/test/build/venv 09:24:23 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 09:24:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:24:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:24:23 INFO - Using real prefix '/tools/python27' 09:24:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:24:24 INFO - Installing distribute.............................................................................................................................................................................................done. 09:24:27 INFO - Installing pip.................done. 09:24:27 INFO - Return code: 0 09:24:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:24:27 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')]} 09:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:27 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')]} 09:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:27 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 0x102faaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a1cacf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e49e00>, '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 0x102cb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e44b20>, '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.7NeIjTs2a7/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.6ljUllclmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:27 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 09:24:27 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 09:24:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7NeIjTs2a7/Render', 09:24:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:27 INFO - 'HOME': '/Users/cltbld', 09:24:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:27 INFO - 'LOGNAME': 'cltbld', 09:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:27 INFO - 'MOZ_NO_REMOTE': '1', 09:24:27 INFO - 'NO_EM_RESTART': '1', 09:24:27 INFO - 'PAGER': '/bin/cat', 09:24:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:27 INFO - 'PWD': '/builds/slave/test', 09:24:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:27 INFO - 'SHELL': '/bin/bash', 09:24:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ljUllclmf/Listeners', 09:24:27 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:27 INFO - 'USER': 'cltbld', 09:24:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:27 INFO - 'XPC_FLAGS': '0x0', 09:24:27 INFO - 'XPC_SERVICE_NAME': '0', 09:24:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:27 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 09:24:27 INFO - Cleaning up... 09:24:27 INFO - Return code: 0 09:24:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:24:27 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')]} 09:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:27 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')]} 09:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:27 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 0x102faaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a1cacf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e49e00>, '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 0x102cb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e44b20>, '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.7NeIjTs2a7/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.6ljUllclmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:27 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 09:24:27 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 09:24:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7NeIjTs2a7/Render', 09:24:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:27 INFO - 'HOME': '/Users/cltbld', 09:24:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:27 INFO - 'LOGNAME': 'cltbld', 09:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:27 INFO - 'MOZ_NO_REMOTE': '1', 09:24:27 INFO - 'NO_EM_RESTART': '1', 09:24:27 INFO - 'PAGER': '/bin/cat', 09:24:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:27 INFO - 'PWD': '/builds/slave/test', 09:24:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:27 INFO - 'SHELL': '/bin/bash', 09:24:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ljUllclmf/Listeners', 09:24:27 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:27 INFO - 'USER': 'cltbld', 09:24:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:27 INFO - 'XPC_FLAGS': '0x0', 09:24:27 INFO - 'XPC_SERVICE_NAME': '0', 09:24:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:27 INFO - Downloading/unpacking psutil>=0.7.1 09:24:27 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 09:24:27 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 09:24:27 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 09:24:27 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 09:24:27 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 09:24:27 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 09:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:24:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:30 INFO - Installing collected packages: psutil 09:24:30 INFO - Running setup.py install for psutil 09:24:30 INFO - building 'psutil._psutil_osx' extension 09:24:30 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 09:24:31 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 09:24:31 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 09:24:31 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 09:24:31 INFO - building 'psutil._psutil_posix' extension 09:24:31 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 09:24:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:24:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:24:31 INFO - ^ 09:24:31 INFO - 1 warning generated. 09:24:31 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 09:24:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:31 INFO - Successfully installed psutil 09:24:31 INFO - Cleaning up... 09:24:31 INFO - Return code: 0 09:24:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09: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')]} 09:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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')]} 09:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:31 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 0x102faaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a1cacf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e49e00>, '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 0x102cb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e44b20>, '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.7NeIjTs2a7/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.6ljUllclmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:31 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 09:24:31 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 09:24:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7NeIjTs2a7/Render', 09:24:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:31 INFO - 'HOME': '/Users/cltbld', 09:24:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:31 INFO - 'LOGNAME': 'cltbld', 09:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:31 INFO - 'MOZ_NO_REMOTE': '1', 09:24:31 INFO - 'NO_EM_RESTART': '1', 09:24:31 INFO - 'PAGER': '/bin/cat', 09:24:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:31 INFO - 'PWD': '/builds/slave/test', 09:24:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:31 INFO - 'SHELL': '/bin/bash', 09:24:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ljUllclmf/Listeners', 09:24:31 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:31 INFO - 'USER': 'cltbld', 09:24:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:31 INFO - 'XPC_FLAGS': '0x0', 09:24:31 INFO - 'XPC_SERVICE_NAME': '0', 09:24:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:24:32 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 09:24:32 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 09:24:32 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 09:24:32 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 09:24:32 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 09:24:32 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 09:24:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:24:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:24:34 INFO - Installing collected packages: mozsystemmonitor 09:24:34 INFO - Running setup.py install for mozsystemmonitor 09:24:34 INFO - Successfully installed mozsystemmonitor 09:24:34 INFO - Cleaning up... 09:24:34 INFO - Return code: 0 09:24:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102faaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a1cacf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e49e00>, '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 0x102cb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e44b20>, '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.7NeIjTs2a7/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.6ljUllclmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7NeIjTs2a7/Render', 09:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:34 INFO - 'HOME': '/Users/cltbld', 09:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:34 INFO - 'LOGNAME': 'cltbld', 09:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:34 INFO - 'MOZ_NO_REMOTE': '1', 09:24:34 INFO - 'NO_EM_RESTART': '1', 09:24:34 INFO - 'PAGER': '/bin/cat', 09:24:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:34 INFO - 'PWD': '/builds/slave/test', 09:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:34 INFO - 'SHELL': '/bin/bash', 09:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ljUllclmf/Listeners', 09:24:34 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:34 INFO - 'USER': 'cltbld', 09:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:34 INFO - 'XPC_FLAGS': '0x0', 09:24:34 INFO - 'XPC_SERVICE_NAME': '0', 09:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:35 INFO - Downloading/unpacking blobuploader==1.2.4 09:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:37 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24:37 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 09:24:37 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 09:24:37 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 09:24:37 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 09:24:37 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 09:24:37 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 09:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:24:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:38 INFO - Downloading docopt-0.6.1.tar.gz 09:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:38 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:38 INFO - Running setup.py install for blobuploader 09:24:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:38 INFO - Running setup.py install for requests 09:24:39 INFO - Running setup.py install for docopt 09:24:39 INFO - Successfully installed blobuploader requests docopt 09:24:39 INFO - Cleaning up... 09:24:39 INFO - Return code: 0 09:24:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24: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')]} 09:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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')]} 09:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:39 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 0x102faaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a1cacf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e49e00>, '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 0x102cb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e44b20>, '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.7NeIjTs2a7/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.6ljUllclmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:39 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 09:24:39 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 09:24:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7NeIjTs2a7/Render', 09:24:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:39 INFO - 'HOME': '/Users/cltbld', 09:24:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:39 INFO - 'LOGNAME': 'cltbld', 09:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:39 INFO - 'MOZ_NO_REMOTE': '1', 09:24:39 INFO - 'NO_EM_RESTART': '1', 09:24:39 INFO - 'PAGER': '/bin/cat', 09:24:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:39 INFO - 'PWD': '/builds/slave/test', 09:24:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:39 INFO - 'SHELL': '/bin/bash', 09:24:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ljUllclmf/Listeners', 09:24:39 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:39 INFO - 'USER': 'cltbld', 09:24:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:39 INFO - 'XPC_FLAGS': '0x0', 09:24:39 INFO - 'XPC_SERVICE_NAME': '0', 09:24:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:39 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-bk1Hum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-WENMdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-5oq8qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-3nymI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-14aRP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-RNq0Ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-CL8reY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-vX0jqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-WRR6jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-MJkPmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-7ZLFHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:41 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-sVDVKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:41 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-U3qs_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:41 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-sc58KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:41 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-_VBz78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:41 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-saStWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:41 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-a6lE6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:24:41 INFO - Running setup.py install for manifestparser 09:24:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:24:41 INFO - Running setup.py install for mozcrash 09:24:41 INFO - Running setup.py install for mozdebug 09:24:42 INFO - Running setup.py install for mozdevice 09:24:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:24:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:24:42 INFO - Running setup.py install for mozfile 09:24:42 INFO - Running setup.py install for mozhttpd 09:24:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:24:42 INFO - Running setup.py install for mozinfo 09:24:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:24:42 INFO - Running setup.py install for mozInstall 09:24:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:24:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:24:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:24:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:24:42 INFO - Running setup.py install for mozleak 09:24:42 INFO - Running setup.py install for mozlog 09:24:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:24:43 INFO - Running setup.py install for moznetwork 09:24:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:24:43 INFO - Running setup.py install for mozprocess 09:24:43 INFO - Running setup.py install for mozprofile 09:24:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:24:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:24:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:24:43 INFO - Running setup.py install for mozrunner 09:24:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:24:43 INFO - Running setup.py install for mozscreenshot 09:24:43 INFO - Running setup.py install for moztest 09:24:44 INFO - Running setup.py install for mozversion 09:24:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:24:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:24:44 INFO - Cleaning up... 09:24:44 INFO - Return code: 0 09:24:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:44 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')]} 09:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:44 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')]} 09:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:44 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 0x102faaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a1cacf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e49e00>, '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 0x102cb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e44b20>, '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.7NeIjTs2a7/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.6ljUllclmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:44 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 09:24:44 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 09:24:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7NeIjTs2a7/Render', 09:24:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:44 INFO - 'HOME': '/Users/cltbld', 09:24:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:44 INFO - 'LOGNAME': 'cltbld', 09:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:44 INFO - 'MOZ_NO_REMOTE': '1', 09:24:44 INFO - 'NO_EM_RESTART': '1', 09:24:44 INFO - 'PAGER': '/bin/cat', 09:24:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:44 INFO - 'PWD': '/builds/slave/test', 09:24:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:44 INFO - 'SHELL': '/bin/bash', 09:24:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ljUllclmf/Listeners', 09:24:44 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:44 INFO - 'USER': 'cltbld', 09:24:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:44 INFO - 'XPC_FLAGS': '0x0', 09:24:44 INFO - 'XPC_SERVICE_NAME': '0', 09:24:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:44 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-LnfU13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:44 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)) 09:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:44 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-vmOWCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:44 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)) 09:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:44 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-oMB8li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:44 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)) 09:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:44 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-qKN8Nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:44 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)) 09:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:44 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-FstHrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:45 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)) 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-bzuY0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:45 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)) 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-ABW89D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:45 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)) 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-CMQbCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:45 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)) 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-rCgugf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:45 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)) 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-gIkZd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:45 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)) 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-SrZnPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:45 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)) 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-9bgG0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:45 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)) 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-mjGwjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:45 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)) 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:45 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-lPqE64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:46 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)) 09:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:46 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-CEk1rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:46 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)) 09:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:46 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-twI_Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:46 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)) 09:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:46 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-KIsR3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:46 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)) 09:24:46 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)) 09:24:46 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)) 09:24:46 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)) 09:24:46 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)) 09:24:46 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)) 09:24:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:48 INFO - Downloading blessings-1.6.tar.gz 09:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:24:48 INFO - Installing collected packages: blessings 09:24:48 INFO - Running setup.py install for blessings 09:24:49 INFO - Successfully installed blessings 09:24:49 INFO - Cleaning up... 09:24:49 INFO - Return code: 0 09:24:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:24:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:49 INFO - Reading from file tmpfile_stdout 09:24:49 INFO - Current package versions: 09:24:49 INFO - blessings == 1.6 09:24:49 INFO - blobuploader == 1.2.4 09:24:49 INFO - docopt == 0.6.1 09:24:49 INFO - manifestparser == 1.1 09:24:49 INFO - mozInstall == 1.12 09:24:49 INFO - mozcrash == 0.17 09:24:49 INFO - mozdebug == 0.1 09:24:49 INFO - mozdevice == 0.48 09:24:49 INFO - mozfile == 1.2 09:24:49 INFO - mozhttpd == 0.7 09:24:49 INFO - mozinfo == 0.9 09:24:49 INFO - mozleak == 0.1 09:24:49 INFO - mozlog == 3.1 09:24:49 INFO - moznetwork == 0.27 09:24:49 INFO - mozprocess == 0.22 09:24:49 INFO - mozprofile == 0.28 09:24:49 INFO - mozrunner == 6.11 09:24:49 INFO - mozscreenshot == 0.1 09:24:49 INFO - mozsystemmonitor == 0.0 09:24:49 INFO - moztest == 0.7 09:24:49 INFO - mozversion == 1.4 09:24:49 INFO - psutil == 3.1.1 09:24:49 INFO - requests == 1.2.3 09:24:49 INFO - wsgiref == 0.1.2 09:24:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:49 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')]} 09:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:49 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')]} 09:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:49 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 0x102faaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a1cacf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e49e00>, '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 0x102cb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e44b20>, '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.7NeIjTs2a7/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.6ljUllclmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:49 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 09:24:49 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 09:24:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7NeIjTs2a7/Render', 09:24:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:49 INFO - 'HOME': '/Users/cltbld', 09:24:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:49 INFO - 'LOGNAME': 'cltbld', 09:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:49 INFO - 'MOZ_NO_REMOTE': '1', 09:24:49 INFO - 'NO_EM_RESTART': '1', 09:24:49 INFO - 'PAGER': '/bin/cat', 09:24:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:49 INFO - 'PWD': '/builds/slave/test', 09:24:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:49 INFO - 'SHELL': '/bin/bash', 09:24:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ljUllclmf/Listeners', 09:24:49 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:49 INFO - 'USER': 'cltbld', 09:24:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:49 INFO - 'XPC_FLAGS': '0x0', 09:24:49 INFO - 'XPC_SERVICE_NAME': '0', 09:24:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:49 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)) 09:24:49 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)) 09:24:49 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)) 09:24:49 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)) 09:24:49 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)) 09:24:49 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)) 09:24:49 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)) 09:24:49 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)) 09:24:49 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)) 09:24:49 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)) 09:24:49 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)) 09:24:49 INFO - Cleaning up... 09:24:49 INFO - Return code: 0 09:24:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:24:49 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')]} 09:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:49 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')]} 09:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:49 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 0x102faaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a1cacf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e49e00>, '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 0x102cb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e44b20>, '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.7NeIjTs2a7/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.6ljUllclmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:49 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 09:24:49 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 09:24:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7NeIjTs2a7/Render', 09:24:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:49 INFO - 'HOME': '/Users/cltbld', 09:24:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:49 INFO - 'LOGNAME': 'cltbld', 09:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:49 INFO - 'MOZ_NO_REMOTE': '1', 09:24:49 INFO - 'NO_EM_RESTART': '1', 09:24:49 INFO - 'PAGER': '/bin/cat', 09:24:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:49 INFO - 'PWD': '/builds/slave/test', 09:24:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:49 INFO - 'SHELL': '/bin/bash', 09:24:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ljUllclmf/Listeners', 09:24:49 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:49 INFO - 'USER': 'cltbld', 09:24:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:49 INFO - 'XPC_FLAGS': '0x0', 09:24:49 INFO - 'XPC_SERVICE_NAME': '0', 09:24:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:49 INFO - Downloading/unpacking jsonschema 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:24:52 INFO - Downloading/unpacking functools32 (from jsonschema) 09:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:52 INFO - Downloading functools32-3.2.3-2.tar.gz 09:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:24:52 INFO - warning: no files found matching '*.txt' 09:24:52 INFO - no previously-included directories found matching 'build' 09:24:52 INFO - no previously-included directories found matching 'dist' 09:24:52 INFO - no previously-included directories found matching '.git*' 09:24:52 INFO - Installing collected packages: jsonschema, functools32 09:24:52 INFO - Running setup.py install for functools32 09:24:53 INFO - warning: no files found matching '*.txt' 09:24:53 INFO - no previously-included directories found matching 'build' 09:24:53 INFO - no previously-included directories found matching 'dist' 09:24:53 INFO - no previously-included directories found matching '.git*' 09:24:53 INFO - Successfully installed jsonschema functools32 09:24:53 INFO - Cleaning up... 09:24:53 INFO - Return code: 0 09:24:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102faaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a1cacf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e49e00>, '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 0x102cb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e44b20>, '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.7NeIjTs2a7/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.6ljUllclmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:24:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7NeIjTs2a7/Render', 09:24:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:53 INFO - 'HOME': '/Users/cltbld', 09:24:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:53 INFO - 'LOGNAME': 'cltbld', 09:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:53 INFO - 'MOZ_NO_REMOTE': '1', 09:24:53 INFO - 'NO_EM_RESTART': '1', 09:24:53 INFO - 'PAGER': '/bin/cat', 09:24:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:53 INFO - 'PWD': '/builds/slave/test', 09:24:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:53 INFO - 'SHELL': '/bin/bash', 09:24:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ljUllclmf/Listeners', 09:24:53 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:24:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:53 INFO - 'USER': 'cltbld', 09:24:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:53 INFO - 'XPC_FLAGS': '0x0', 09:24:53 INFO - 'XPC_SERVICE_NAME': '0', 09:24:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:53 INFO - Downloading/unpacking flake8 09:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:24:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:24:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:24:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:24:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:24:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:24:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:24:57 INFO - no previously-included directories found matching 'docs/_build' 09:24:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:24:57 INFO - Running setup.py install for pep8 09:24:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:24:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:24:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:24:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:24:57 INFO - no previously-included directories found matching 'docs/_build' 09:24:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:24:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:24:57 INFO - Cleaning up... 09:24:57 INFO - Return code: 0 09:24:57 INFO - Running post-action listener: _resource_record_post_action 09:24:57 INFO - Running post-action listener: _start_resource_monitoring 09:24:57 INFO - Starting resource monitoring. 09:24:57 INFO - ##### 09:24:57 INFO - ##### Running install step. 09:24:57 INFO - ##### 09:24:57 INFO - Running pre-action listener: _resource_record_pre_action 09:24:57 INFO - Running main action method: install 09:24:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:57 INFO - Reading from file tmpfile_stdout 09:24:57 INFO - Detecting whether we're running mozinstall >=1.0... 09:24:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:24:57 INFO - Reading from file tmpfile_stdout 09:24:57 INFO - Output received: 09:24:57 INFO - Usage: mozinstall [options] installer 09:24:57 INFO - Options: 09:24:57 INFO - -h, --help show this help message and exit 09:24:57 INFO - -d DEST, --destination=DEST 09:24:57 INFO - Directory to install application into. [default: 09:24:57 INFO - "/builds/slave/test"] 09:24:57 INFO - --app=APP Application being installed. [default: firefox] 09:24:57 INFO - mkdir: /builds/slave/test/build/application 09:24:57 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'] 09:24:57 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 09:25:19 INFO - Reading from file tmpfile_stdout 09:25:19 INFO - Output received: 09:25:19 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:25:19 INFO - Running post-action listener: _resource_record_post_action 09:25:19 INFO - ##### 09:25:19 INFO - ##### Running run-tests step. 09:25:19 INFO - ##### 09:25:19 INFO - Running pre-action listener: _resource_record_pre_action 09:25:19 INFO - Running main action method: run_tests 09:25:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:25:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:25:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:25:19 INFO - 2016-06-23 09:25:19.923 screenresolution[1636:7345] starting screenresolution argv=screenresolution get 09:25:19 INFO - 2016-06-23 09:25:19.925 screenresolution[1636:7345] Display 0: 1600x1200x32@60 09:25:19 INFO - 2016-06-23 09:25:19.930 screenresolution[1637:7348] starting screenresolution argv=screenresolution list 09:25:19 INFO - Available Modes on Display 0 09:25:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:25:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:25:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:25:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:25:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:25:20 INFO - Intel Iris: 09:25:20 INFO - Chipset Model: Intel Iris 09:25:20 INFO - Type: GPU 09:25:20 INFO - Bus: Built-In 09:25:20 INFO - VRAM (Dynamic, Max): 1536 MB 09:25:20 INFO - Vendor: Intel (0x8086) 09:25:20 INFO - Device ID: 0x0a2e 09:25:20 INFO - Revision ID: 0x0009 09:25:20 INFO - Displays: 09:25:20 INFO - Display: 09:25:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:25:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:25:20 INFO - Display Serial Number: 1600x1200 60 09:25:20 INFO - Main Display: Yes 09:25:20 INFO - Mirror: Off 09:25:20 INFO - Online: Yes 09:25:20 INFO - Rotation: Supported 09:25:20 INFO - Return code: 0 09:25:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:25:20 INFO - Python 2.7.3 09:25:20 INFO - Return code: 0 09:25:20 INFO - grabbing minidump binary from tooltool 09:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:20 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 0x102e49e00>, '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 0x102cb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e44b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:25:20 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 09:25:20 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 09:25:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:20 INFO - Return code: 0 09:25:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:25:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:25:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:25:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:25:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:25:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:25:21 INFO - Return code: 0 09:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0144 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:25:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7NeIjTs2a7/Render', 09:25:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:21 INFO - 'HOME': '/Users/cltbld', 09:25:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:21 INFO - 'LOGNAME': 'cltbld', 09:25:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:25:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:21 INFO - 'MOZ_NO_REMOTE': '1', 09:25:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:25:21 INFO - 'NO_EM_RESTART': '1', 09:25:21 INFO - 'PAGER': '/bin/cat', 09:25:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:21 INFO - 'PWD': '/builds/slave/test', 09:25:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:25:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:21 INFO - 'SHELL': '/bin/bash', 09:25:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ljUllclmf/Listeners', 09:25:21 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:25:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:21 INFO - 'USER': 'cltbld', 09:25:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:21 INFO - 'XPC_FLAGS': '0x0', 09:25:21 INFO - 'XPC_SERVICE_NAME': '0', 09:25:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:25:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:25:21 INFO - mozversion application_buildid: 20160623071724 09:25:21 INFO - mozversion application_changeset: 2c5721ac42d71b2359320646afbdc7a919a60fd3 09:25:21 INFO - mozversion application_display_name: Firefox 09:25:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:21 INFO - mozversion application_name: Firefox 09:25:21 INFO - mozversion application_remotingname: firefox 09:25:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:25:21 INFO - mozversion application_vendor: Mozilla 09:25:21 INFO - mozversion application_version: 48.0 09:25:21 INFO - mozversion platform_buildid: 20160623071724 09:25:21 INFO - mozversion platform_changeset: 2c5721ac42d71b2359320646afbdc7a919a60fd3 09:25:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:25:21 INFO - mozversion platform_version: 48.0 09:25:21 INFO - using testdate: 1466699121 09:25:21 INFO - actual date: 1466699121 09:25:21 INFO - starting webserver on 'localhost:49274' 09:25:21 INFO - SUITE-START | Running 2 tests 09:25:21 INFO - TEST-START | dromaeo_css 09:25:21 INFO - operating with platform_type : mac_ 09:25:21 INFO - Initialising browser for dromaeo_css test... 09:25:21 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmp6mVkgg/profile http://localhost:49274/getInfo.html) 09:25:24 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 09:25:24 INFO - PROCESS | 1655 | colorDepth:24 09:25:24 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 09:25:24 INFO - PROCESS | 1655 | __metrics 09:25:24 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:25:24 ERROR - PROCESS | 1655 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:25:24 INFO - TEST-INFO | 1655: exit 0 09:25:24 INFO - Browser initialized. 09:25:24 INFO - Running cycle 1/1 for dromaeo_css test... 09:25:24 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmp6mVkgg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:36 INFO - PROCESS | 1658 | RSS: Main: 161406976 09:25:36 INFO - PROCESS | 1658 | 09:26:28 INFO - PROCESS | 1658 | 1466699188206 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] 09:28:38 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 09:28:39 INFO - PROCESS | 1658 | RSS: Main: 255717376 09:28:39 INFO - PROCESS | 1658 | 09:31:42 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 09:31:42 INFO - PROCESS | 1658 | RSS: Main: 302104576 09:31:42 INFO - PROCESS | 1658 | 09:34:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 09:34:45 INFO - PROCESS | 1658 | RSS: Main: 313606144 09:34:45 INFO - PROCESS | 1658 | 09:37:47 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 09:37:47 INFO - PROCESS | 1658 | RSS: Main: 306200576 09:37:47 INFO - PROCESS | 1658 | 09:40:50 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 09:40:51 INFO - PROCESS | 1658 | RSS: Main: 271806464 09:40:51 INFO - PROCESS | 1658 | 09:43:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 09:43:54 INFO - PROCESS | 1658 | RSS: Main: 315596800 09:43:54 INFO - PROCESS | 1658 | 09:43:54 INFO - PROCESS | 1658 | __start_tp_report 09:43:54 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 09:43:54 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 09:43:54 INFO - PROCESS | 1658 | |i|pagename|runs| 09:43:54 INFO - PROCESS | 1658 | |0;dojo.html;3537.2041290709594;3585.6952159066477;3590.658887405697;3608.8556457741684;3663.9633603663974;5779;5838.41615838416;5853.7365818538165;5855.941440585603;5891.998360278758;5832.358440571545;5864.530837532998;5880.941190588103;5886.764529418829;5894.4989675877605;5247.606429517801;5247.842564723064;5283.07546179419;5331.866703332409;5389.461053894618;5348.518633323;5380.784768609271;5392.622516423852;5395.81114660987;5398.676079435247;5302.946970530284;5357.008953343625;5378.515933565978;5380.838574842742;5389.164679474688;5352.839414817562;5362.222477740745;5368.114261146906;5368.892622147535;5401.189821526763;5118.795248190105;5283.154695248781;5287.735613219324;5289.285946397225;5315.229291752674;5721.056025755745;5722.198892155102;5753.367129615739;5792.652440853562;5807.128930660392;6179.412955769195;6196.690165491753;6211.937880621226;6214.65819379934;6215.502759779207;6106.794380079898;6210.130581718563;6210.243556585193;6241.34465881085;6245.594036387621;5906.645601263938;5998.730057147439;6004.519638428916;6024.337322894478;6046.6069705469445;6256.468200203034;6300.842478938063;6308.116863639094;6314.968425157845;6331.715072821734;6142.539309551712;6207.5654704171175;6210.7515699372425;6212.782552610637;6220.25356957159;6164.291106522717;6241.375862413723;6259.96870015647;6266.905996410058;6299.307076221612;6151.661658608819;6166.260048794174;6199;6210.347913469111;6218.253809542884;6133.334663918993;6180.938190618126;6215.564910456315;6223.813285601439;6239.407256310643;4993.600511959107;5001.624878134082;5039.143345631178;5053.115704751727;5089.9745501272255;4406.691531592758;4526.932096018562;4541.250693635513;4544.318352247189;4603.8849028773875;5748.913766293509;5836.620619659709;5841.182234487175;5877.882442351129;5903.144044113579;6229.906551401733;6240.875182496325;6271.3415091414745;6273.466755325849;6280.183576135073;5850.239468869105;5864.9413505864395;5880.0591905295805;5910.139623692285;5910.911336329958;5385.084535628953;5417.51242388187;5475.835724928259;5491.203775452537;5502.9174562381595;6371.52213583983;6415.1981002374705;6419.1334169887405;6421.293657697556;6443.613383197023;6206.72069756853;6233.781817636361;6250.781222657185;6255.96872015637;6284.151639528788;6281.905771413524;6367.395097465734;6424.421802037652;6427.55007149495;6440.066190402459;6172.876542469216;6242.687865606792;6244;6250.968745156427;6252.093446450148;5815.156802263733;6111.938880611315;6261.624302541862;6266.843328916813;6287.559870808999;6074.271087469532;6086.452219300284;6134.171886795404;6165.260168779775;6197.504199664107;6204.3795620437595;6212.099245609452;6217.440430361289;6228.937710623017;6241.563090583615;5789.681567513827;6068.180795592715;6075.513958883191;6077.726502307495;6129.264488261437;6030.638161710312;6098.054801505774;6115.419458243266;6127.754889804358;6141.938580614136;6117.724373814389;6123.648682309606;6147.016477363601;6148.047052706837;6158.952977993662 09:43:54 INFO - PROCESS | 1658 | |1;ext.html;535.1491129104724;554.6893739505874;567.3872218004554;569.4078158714937;611.2451122863263;33009.33981320372;33556;33588.4961725574;33627.15932101692;33672.98981030567;34978.95063148109;35528.64471355286;39432.80283598578;40714.7964260179;40946.38580421296;9837.262205334593;9995.450250236234;10002.349847259904;10015.69952901414;10018.148457381096;9868.45723485208;9992.45041522716;9996.750081247954;10001.399916005063;10001.749956251115;9335.113164249386;12099;12336.62990110298;12347.259164450117;12364.134510584263;10134.239932005092;11945.402729863472;12070.577529786504;12073.637790866289;12081.456334464881;11718.589849355318;11851.822222666668;11864.050875929992;11865.466054027589;11870.762584748256;40558.797206014075;41042.38436423456;41077.79461102705;41162.588374116174;41226.79386603048;3336.616289126733;3378.3918894598964;3878.6703130233964;3918.0596656802445;3985.880423587268;28708.569371459445;29295.560566591517;29665.70334296651;29818.403631927456;29996.250093747833;2753.600727894444;2784.7076057013924;2833.9858300708365;2896.5075937090533;2910.4179164167253;360711;362114;363463;364034;364246.3575364239;37173.62826371756;38013.04967375782;38069.048273792825;38188.61811381906;60869.69565152234;35640.821795891374;35811.64188358135;35873.64126358755;35936.46095308573;35968.46047309293;16010.679786404207;16121.677566448605;16125.354985800672;16129.596760080856;16198.838011619968;13526;13570.796438053438;13584.388702508411;13593.048486605843;13880.958928080232;7855.410844186709;8182.1817818217705;8351.791205219919;8482.279006284534;8485.575721214038;3532.152283451953;3607.8917632470543;3608.855645774192;3616.5840928293055;3627.1294889226397;979.5934687104772;1012.8757079641592;1016.6899095775859;1020.8107554698693;1160.988390116105;28929.710702892702;29426;29426;29962.250943726147;30276.24309392239;910.2217603948661;1099.725068732817;1149.4769879704713;1173.9530418783324;1258.5595041735319;11743.471543780379;14729.92635036818;15299.137612295395;15323.693526129415;15597.220138993005;624692;625963;627366;627835;630200;53637.731811340695;53788;53817.46182538203;54046.45953540493;54522;1556.3229994952005;1571.772093046479;1591.7373633350599;1594.003747657714;1595.1705113340997;25551.105711300017;25856.48287034211;26193;26285.605715913895;26433.942642294092;49908;50104;50168;50232.49767502278;50240.492785216506;424610;439275;439536;612447;826767;27039.594406084318;27123.186304410898;27809.44381112407;27861.721382785912;27861.860690696416;46912;47151.52848471471;47268;47435.57768089512;48827.02345953132;34060.31879362449;36966.890993270245;38410.80794596121;38491.037724057125;38525.229495410495;30130.69869301279;38025.619743802206;38266.808665956494;38571.80714096524;38682.806585968014;37961.21297953937;38029.61970380261;38436.42345364766;38536.229275414895;38854.805725971186;32627.694892204046;33671.82148624786;33680.15799605029;33839.83080084584;33857.15357116092;21402.357929262147;25004.624930626418;25297.62053569235;25717.228483144787;25898.4472514858 09:43:54 INFO - PROCESS | 1658 | |2;jquery.html;412.59771722570497;413.78483188741876;416.2382839403891;416.3255526047802;426.9786510674467;20169.798302016974;20350.389488315337;20835.791642083575;20857.061432235547;21545.353639390803;21465.141394344206;21553.245636402728;21838.89080554599;21880.23419180329;21911.0140043698;5635.295588051484;6168.876622467548;6194.690265486708;6196.16351792509;6200.914839903022;6004;6118.938810611881;6133.570650054498;6143.201383820097;6150.415710507517;5249.895002099975;5808.4481974212595;6085.695715214244;6151.415615516541;6161.568690191689;5789.478946894799;6016.639001659914;6089.634621922699;6098.359672234418;6102.5117990560875;5339.145736682112;5359.222912677679;5366.221897824794;5369.087255166631;5376.1398176291605;25480.980760769547;25951.35121621956;26314.342141446425;26356.341091472674;26359.20922372332;2069.182672844218;2194.6049711052005;2452.288836237507;2461.310832966772;2937.9276564053966;9798.853017204749;9800.90199098007;9928.255380846393;9994.350367226107;10193.898061019368;1602.2789744614854;1818.7180986947044;1834.3121329501437;1845.474039898636;1874.6250749849949;94644;102589.46115808269;104408.47795761049;108100;110324;10168.28821982454;10813.945930270298;11300.982911538002;11576.131790115774;11870.821937670942;14867.033642813183;14867.107973521623;14901.882358823132;14914.17972011528;14915.925420373045;8760.824783504295;8877.422967507091;8926.776830579287;9015.549222538846;9118.86321705175;7329.047223860864;8201.71294004707;9045.728628141167;9060.592273347715;9107.271418286522;4585.885352866205;4662.6269898408045;4685.149366000411;4711.434627844681;4712.717236965725;1817.7275906865248;1834.9082545872652;1953.7948515405678;1972.723818665388;1995.4013795861183;937.6952490440634;950.8383574792302;979.5738853598707;1029.9227557933184;1103.569607852938;19379.90310048469;20259;20273.79726202719;20441.795582044288;20581.69127463089;998.4957596413765;1008.2639673038723;1034.4103860799423;1047.4448542272455;1066.3015724700333;10364.481775911325;10662.413567253876;10887.18346124028;10903.454827258605;10928.617498387519;645397;648801;656823;657182;668469;100483;116737;124177;125868.37065814795;129568;1041.3959903256093;1047.1361127070197;1060.5015642647943;1065.989340106589;1070.1652710885521;17488.650226995134;17707.645847083244;17956;18060.458186254433;18228;39208;46868.737349759955;50844;51544;51693;70455;74152;74732.62633686796;76769.61615192112;76991.84512232209;7452.50949810051;8127.552984585905;8268.917310826815;8487;8597.88227530417;10374.962503749564;12040.337781422106;12521.499140034297;12891.355432228163;13072.281024543361;9713.465759383302;10940.343579384944;11188.944055279671;11303.321800691985;11511.079113671054;8751.868721969047;11055.83416248773;11134.55461781552;11342.092632589538;11487.25332853362;11440.656780296604;11458.656240312805;11576.768464630492;11771;11808.527658893549;8112.269895709414;8339.583020849055;8363.330933525425;8378.49729016261;8583.141685831368;10326.122279606017;11354.432278385882;11583.420828958688;11589.826152607886;11656.53373865036 09:43:54 INFO - PROCESS | 1658 | |3;mootools.html;1304.3413076396419;1592.0368177252758;1597.400974634512;1630.9429169979046;1983.4743792894885;7179.174394944583;7804;8764.693235736759;8770.210681038705;8786.297096232302;8518.744437666865;8763.86854197186;8766.123387661246;8767.342449316295;8778.078301778318;2500.9749902501017;2533.037445770614;2534.847909125449;2536.353229926366;2539.0224763466013;2470.1601455505124;2514.4091138582417;2518.0809004713333;2518.244526642009;2526.6462695222685;2486.751324867517;2514.673092497982;2547.757962993522;2551.4514379408424;2553.221267513408;2488.713797913236;2523.671922650053;2525.1414519063514;2526.6715327007555;2527.9747202527924;2482.937926551833;2519.5464816333238;2527.747225277476;2527.8356906801;2531.6455696202547;8636.438631488996;8910.415979365976;8974.967878693968;8979.281657467387;9020.8646870297;5411.242426060355;5491.752871120809;5504.6421982571;5530.806421775259;5542.695151766651;3540.5574303212097;3598.226381328027;3629.909252268688;3645.0887278180453;3670.72469564781;1063.6330465989222;1065.6749691344137;1066.2163309967168;1073.9463026848625;1081.1836115326248;11660.650180494598;11759.294442333487;11963;11993.220440671328;12020;4596.655250856199;4596.839110631112;4710.505396933341;4740.336352910595;4746.786394612251;9449.952750236342;9453.432794032242;9464.432134071978;9464.763380915394;9465.432074075577;5435.809746658848;5464.808731694372;5470.425605311465;5471.644343117685;5482.17767334903;4524.6832721709825;4693.342931989524;4857.028594281158;5043.798248070109;5070.923936140961;3858.6141385861188;3969.563348031714;3979.144483935968;4005.539362973237;4022.2759903217116;1233.5004323249098;1248.5630029489787;1251.8810712982252;1258.8929940955122;1263;902.8194361127801;943.5895385507326;950.4724877692947;968.2834702320232;1005.0652892809611;5996.640201587831;6018.8194354169445;6164.845878853064;6194.101855230966;6219.098230756515;416.9770662613585;465.57167405986576;470.4777696756598;477.6680207255924;484.9490803465656;3953.940690889639;3976.443297938291;4026.154507553388;4057.4928133983253;4122.752634841919;10420.270581059252;10814.026737593655;10888.727781805519;10898.945505272422;10916.290441121302;10554.894451055392;10564.36613803159;10689.625863094754;10717.78564428707;10728.302660327054;8319.958400207961;8410.03284622264;8414.579271036424;8418.915810841936;8420.15798420153;5931.733072011683;5938.970305148619;5960.910586341295;5963.194968679173;6152.354002829818;9346.672866449642;9552.522373881417;9663.758406039906;9673.419594824332;9676.22590192797;9462.952685236529;9855.901440985785;9874.851877221703;9926.553305101143;10022.649207277711;6977.476689248225;7163.713451461883;7351.301626345488;7537.434692397982;7618.085829700472;8373.371997100363;8379.622916968872;8434.114417986268;8441.409101362846;8485.321174305916;7382.778516644509;7534.133574638768;7555.773326800205;7621.542766977407;7687.577183254974;6430.196225471816;7310.159331676925;7394.7781566553085;7415;7503;7070.6111163884425;7145.214026456982;7150.463715221275;7154.892676609959;7161.892571611535;4937.629677774253;4979.153543897473;5011.674241174312;5029.84910452687;5060.873478163076;4940.11078005948;5003.824866129814;5007.37407824022;5103.87240318995;5243.501867322599 09:43:54 INFO - PROCESS | 1658 | |4;prototype.html;302.7109110799187;332.8768355708388;340.1699852360242;341.90084875386134;344.81207741780725;6620.569662971916;6741.089952856369;6758.628275444848;6773.119494465713;6802.829929251765;5375.892482150354;6515.543911926167;6761.898571521431;6777.932220677804;6781.118454600895;4994.200927851544;5053.140966035783;5054.494550544934;5067.062593420229;5072;4792.9760351198365;4851.175300198975;5059.949400506003;5063.417706963691;5074;4959.156943319645;4961.925571116418;4973.751312434382;4983.825566105187;5010.0981823271795;3866.2654095722005;4489.304157855538;5012.649114561982;5033.697978121324;5041.269015992697;4286.935695964563;4289.249381358281;4294.592013758688;4294.871153865389;4298.333758267474;6230.2523697156175;6436.774712885073;6443.484521238336;6444.677766111722;6448;5053.620978426633;5714.371419143932;5896.351401345849;5903.793367232126;5910.556708246899;7158.463115266324;7168.247334029956;7185.461090418187;7192.136943566806;7198.460115491359;4264.850730224427;4463.843765468226;4788.209945359012;4788.592969597588;4803.495632958524;7532.17146113927;7533.322001019935;7534.736284230025;7542.811429714301;7552.207018263058;4341.804618792162;4765.0231702500905;4878.487758785347;4878.512148785093;4885.60915126789;4747.548982846624;4934.629902757236;4940.2342636891335;4950.43070046942;4950.653454258239;5772.047612144033;5914.792982245601;5926.496247818897;5936.851578710567;5938.940610593925;5954.285485741739;7178.892316615255;7190.568565886064;7192.208857025723;7213.711451541984;1631.2007116512823;1674.9950029982158;1682.87378446617;1700;1730.2732852202105;1109.5949978257877;1111.899929006377;1119.054399032816;1122.2537012886503;1128.7403897103547;4727.810887564528;6609.074729537869;6614.669266536654;6645.368689974444;6675.499337549703;6125.387461253839;7422.480426370103;7422.96288518554;7437.7768666939;7453.068366454193;5356.330458692663;6652.966735166293;6659.833504162435;6660.301623086082;6667.466602671775;3901.3367727486398;3943.3099207638547;3944.4083387491532;3950.664193543581;3954.8220330085214;7483.2516748325825;7845.411594130463;7871.685132594746;7894.328982036591;7896.170902055316;6148.477379422709;7633.313001829751;7659.846803063908;7672.424568157299;7674.194209607911;7812.765617031499;7823.647935842901;7829.295363417206;7831.960840195762;7835.0989636191425;7198.136223653195;7426.2945020223;7430.888536671846;7431.331180193809;7447.143578488543;7332.523385979895;7382.52013619113;7402.370798481974;7402.888956665762;7432.21961694036;7923.088844782924;7928.405369597188;7940.364770818436;7942.285194332538;7946.086200087064;4692.765361731968;4719.834805781781;4723.929141062956;4727.976360118178;4741.075490279362;6779.864402712017;7243.674034668347;7498.512596681198;7502.437317201341;7513.1359893612935;7132.679029443584;7160.928390716234;7183.389411899838;7184.820379490555;7194.100737407824;7144.642767861482;7180.820479488055;7190.640467976685;7203.135623725187;7208.8918666219;7021.0872586565465;7024.613646249505;7031.1211098612675;7033.788986330418;7052.682629281592;5823.79616713413;6982.092327997328;7188.856222875409;7190.280971902768;7210.603416812126;7128.322809333105;7155.391791697764;7159.964200178966;7181.245969173162;7188.892166617609 09:43:54 INFO - PROCESS | 1658 | |5;yui.html;706.5760543673796;731.9377852882504;760.4220792197927;773.2653978720214;781.1368437876148;15302.846971530282;15594.45419410321;15640;15645.452409165682;15660.921695391522;14270.785938210935;14442.711145777079;14465.927670361634;14470.204138772364;14475.855241447582;742.1391186223981;764.0106062648855;906.9682561110362;942.006183476432;944.7921457279422;919.6045700348848;932.4545141092469;934.5374039850284;936.1060187520901;936.4755736787387;980.6077568972397;993.3046867192994;994.7115336552428;997.1574019953129;1000.7948370584013;788.2393490281877;806.5241507510567;806.753940048285;808.127222599594;977.613842532203;756.4893696754668;758.6851456645486;759.4418102694515;759.9962000190019;760.5626764610371;15237.6190595236;15296.005759625588;15303.617409564738;15305.387784488606;15317.31072101758;12710.300933448656;12735.745285094246;12802.42389092493;12822.935885320607;13047.478100875953;9997.800043999152;10105.646302379455;10213.387196768217;10480.371177729361;10512;2861.2846788302923;3549.6095429502734;3596;3626.12972886508;3804.1821008483307;81682.59158704228;81979.59010204911;84387.15612843854;84526;84540.73188902233;9613.90386096144;9700.611975521042;9752.463614501128;9896.208303335716;10378.42918639467;21876.781232187794;22105.557888842453;22128.00423980925;22139;22146.22488212905;7775.066991960888;7795.181505941908;7863.764087077397;7886.132525422199;8094.31198348147;4278.4865816102265;4333.198358303724;4376.168527979674;4390.253656878338;4616.699914505613;3706.944395834065;3764.9811750941617;3768.9434658480145;3771.321162190832;3785.73499855013;654.7119267522274;666.6600033982606;669.2972379002028;674.305465370669;692.1452006771633;612.8284080457479;615.0528186592686;617.4042049422329;624.4348864277836;625.562106525434;7423.777286681408;7593.430492713069;7924.049114106228;7935.563544005136;8140.5929703514585;529.0767610519667;532.5233915645475;567.5658121537027;596.4393470138057;642.1235014205575;3534.6642069003406;3801.9354580717445;3926.489556357655;3989.1822176453757;4045.1707399982934;82833.75749363765;88790.66813997795;92610;94523.52738236265;96140.51929740446;83816.16183838206;83895;85991;86594.13405865987;87213.25573488495;71753.64123179455;71847.2815271851;72737;73294.63352683203;75761.24238757652;7650.655720492702;7720.652570634223;7869.8819517708425;7986.401019923645;8190.262876341158;52122.21816672677;52297.95404091821;52449.951000979;52808.94382112413;52906;52326;68928.6553567229;70107;72715.27284727085;73449.6327518359;8068.3545316373375;10054.447005414773;10116.696499105039;10154.187664986932;10920.2901811382;11927.46326415296;12047.457864396298;12116.636500904988;12414.193077449936;12526.311052892179;11781.882181178078;11784.882151178379;11810.350430726048;11868.347240901488;12030.338331391857;11953.760924781282;12043.277403355827;12053.491650616412;12141.332226727614;12259;11699.707507312385;11749.823752643546;11892.524299027942;12077.51689932393;12108.334041627795;9556.808863822545;9606.567704453457;9869.851952220579;9999.35004224723;10063.949680251551;9204.079592041011;9258.49078300673;9495.43027418357;9586.765349568352;9591.760205994906 09:43:54 INFO - PROCESS | 1658 | __end_tp_report 09:43:54 INFO - PROCESS | 1658 | __start_cc_report 09:43:54 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1153 09:43:54 INFO - PROCESS | 1658 | __end_cc_report 09:43:54 INFO - PROCESS | 1658 | __startTimestamp1466700234464__endTimestamp 09:43:54 INFO - PROCESS | 1658 | 09:43:54 INFO - PROCESS | 1658 | ------- Summary: start ------- 09:43:54 INFO - PROCESS | 1658 | Number of tests: 6 09:43:54 INFO - PROCESS | 1658 | 09:43:54 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5828.34 Median:6086.45 stddev:595.48 (9.8%) stddev-sans-first:569.53 09:43:54 INFO - PROCESS | 1658 | Values: 3537.2 3585.7 3590.7 3608.9 3664.0 5779.0 5838.4 5853.7 5855.9 5892.0 5832.4 5864.5 5880.9 5886.8 5894.5 5247.6 5247.8 5283.1 5331.9 5389.5 5348.5 5380.8 5392.6 5395.8 5398.7 5302.9 5357.0 5378.5 5380.8 5389.2 5352.8 5362.2 5368.1 5368.9 5401.2 5118.8 5283.2 5287.7 5289.3 5315.2 5721.1 5722.2 5753.4 5792.7 5807.1 6179.4 6196.7 6211.9 6214.7 6215.5 6106.8 6210.1 6210.2 6241.3 6245.6 5906.6 5998.7 6004.5 6024.3 6046.6 6256.5 6300.8 6308.1 6315.0 6331.7 6142.5 6207.6 6210.8 6212.8 6220.3 6164.3 6241.4 6260.0 6266.9 6299.3 6151.7 6166.3 6199.0 6210.3 6218.3 6133.3 6180.9 6215.6 6223.8 6239.4 4993.6 5001.6 5039.1 5053.1 5090.0 4406.7 4526.9 4541.3 4544.3 4603.9 5748.9 5836.6 5841.2 5877.9 5903.1 6229.9 6240.9 6271.3 6273.5 6280.2 5850.2 5864.9 5880.1 5910.1 5910.9 5385.1 5417.5 5475.8 5491.2 5502.9 6371.5 6415.2 6419.1 6421.3 6443.6 6206.7 6233.8 6250.8 6256.0 6284.2 6281.9 6367.4 6424.4 6427.6 6440.1 6172.9 6242.7 6244.0 6251.0 6252.1 5815.2 6111.9 6261.6 6266.8 6287.6 6074.3 6086.5 6134.2 6165.3 6197.5 6204.4 6212.1 6217.4 6228.9 6241.6 5789.7 6068.2 6075.5 6077.7 6129.3 6030.6 6098.1 6115.4 6127.8 6141.9 6117.7 6123.6 6147.0 6148.0 6159.0 09:43:54 INFO - PROCESS | 1658 | 09:43:54 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:63522.97 Median:34519.63 stddev:142848.05 (413.8%) stddev-sans-first:143170.49 09:43:54 INFO - PROCESS | 1658 | Values: 535.1 554.7 567.4 569.4 611.2 33009.3 33556.0 33588.5 33627.2 33673.0 34979.0 35528.6 39432.8 40714.8 40946.4 9837.3 9995.5 10002.3 10015.7 10018.1 9868.5 9992.5 9996.8 10001.4 10001.7 9335.1 12099.0 12336.6 12347.3 12364.1 10134.2 11945.4 12070.6 12073.6 12081.5 11718.6 11851.8 11864.1 11865.5 11870.8 40558.8 41042.4 41077.8 41162.6 41226.8 3336.6 3378.4 3878.7 3918.1 3985.9 28708.6 29295.6 29665.7 29818.4 29996.3 2753.6 2784.7 2834.0 2896.5 2910.4 360711.0 362114.0 363463.0 364034.0 364246.4 37173.6 38013.0 38069.0 38188.6 60869.7 35640.8 35811.6 35873.6 35936.5 35968.5 16010.7 16121.7 16125.4 16129.6 16198.8 13526.0 13570.8 13584.4 13593.0 13881.0 7855.4 8182.2 8351.8 8482.3 8485.6 3532.2 3607.9 3608.9 3616.6 3627.1 979.6 1012.9 1016.7 1020.8 1161.0 28929.7 29426.0 29426.0 29962.3 30276.2 910.2 1099.7 1149.5 1174.0 1258.6 11743.5 14729.9 15299.1 15323.7 15597.2 624692.0 625963.0 627366.0 627835.0 630200.0 53637.7 53788.0 53817.5 54046.5 54522.0 1556.3 1571.8 1591.7 1594.0 1595.2 25551.1 25856.5 26193.0 26285.6 26433.9 49908.0 50104.0 50168.0 50232.5 50240.5 424610.0 439275.0 439536.0 612447.0 826767.0 27039.6 27123.2 27809.4 27861.7 27861.9 46912.0 47151.5 47268.0 47435.6 48827.0 34060.3 36966.9 38410.8 38491.0 38525.2 30130.7 38025.6 38266.8 38571.8 38682.8 37961.2 38029.6 38436.4 38536.2 38854.8 32627.7 33671.8 33680.2 33839.8 33857.2 21402.4 25004.6 25297.6 25717.2 25898.4 09:43:54 INFO - PROCESS | 1658 | 09:43:54 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:35814.69 Median:2323.45 stddev:108375.59 (4664.4%) stddev-sans-first:108647.01 09:43:54 INFO - PROCESS | 1658 | Values: 412.6 413.8 416.2 416.3 427.0 20169.8 20350.4 20835.8 20857.1 21545.4 21465.1 21553.2 21838.9 21880.2 21911.0 5635.3 6168.9 6194.7 6196.2 6200.9 6004.0 6118.9 6133.6 6143.2 6150.4 5249.9 5808.4 6085.7 6151.4 6161.6 5789.5 6016.6 6089.6 6098.4 6102.5 5339.1 5359.2 5366.2 5369.1 5376.1 25481.0 25951.4 26314.3 26356.3 26359.2 2069.2 2194.6 2452.3 2461.3 2937.9 9798.9 9800.9 9928.3 9994.4 10193.9 1602.3 1818.7 1834.3 1845.5 1874.6 94644.0 102589.5 104408.5 108100.0 110324.0 10168.3 10813.9 11301.0 11576.1 11870.8 14867.0 14867.1 14901.9 14914.2 14915.9 8760.8 8877.4 8926.8 9015.5 9118.9 7329.0 8201.7 9045.7 9060.6 9107.3 4585.9 4662.6 4685.1 4711.4 4712.7 1817.7 1834.9 1953.8 1972.7 1995.4 937.7 950.8 979.6 1029.9 1103.6 19379.9 20259.0 20273.8 20441.8 20581.7 998.5 1008.3 1034.4 1047.4 1066.3 10364.5 10662.4 10887.2 10903.5 10928.6 645397.0 648801.0 656823.0 657182.0 668469.0 100483.0 116737.0 124177.0 125868.4 129568.0 1041.4 1047.1 1060.5 1066.0 1070.2 17488.7 17707.6 17956.0 18060.5 18228.0 39208.0 46868.7 50844.0 51544.0 51693.0 70455.0 74152.0 74732.6 76769.6 76991.8 7452.5 8127.6 8268.9 8487.0 8597.9 10375.0 12040.3 12521.5 12891.4 13072.3 9713.5 10940.3 11188.9 11303.3 11511.1 8751.9 11055.8 11134.6 11342.1 11487.3 11440.7 11458.7 11576.8 11771.0 11808.5 8112.3 8339.6 8363.3 8378.5 8583.1 10326.1 11354.4 11583.4 11589.8 11656.5 09:43:54 INFO - PROCESS | 1658 | 09:43:54 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5731.98 Median:5020.76 stddev:3163.71 (63.0%) stddev-sans-first:3155.08 09:43:54 INFO - PROCESS | 1658 | Values: 1304.3 1592.0 1597.4 1630.9 1983.5 7179.2 7804.0 8764.7 8770.2 8786.3 8518.7 8763.9 8766.1 8767.3 8778.1 2501.0 2533.0 2534.8 2536.4 2539.0 2470.2 2514.4 2518.1 2518.2 2526.6 2486.8 2514.7 2547.8 2551.5 2553.2 2488.7 2523.7 2525.1 2526.7 2528.0 2482.9 2519.5 2527.7 2527.8 2531.6 8636.4 8910.4 8975.0 8979.3 9020.9 5411.2 5491.8 5504.6 5530.8 5542.7 3540.6 3598.2 3629.9 3645.1 3670.7 1063.6 1065.7 1066.2 1073.9 1081.2 11660.7 11759.3 11963.0 11993.2 12020.0 4596.7 4596.8 4710.5 4740.3 4746.8 9450.0 9453.4 9464.4 9464.8 9465.4 5435.8 5464.8 5470.4 5471.6 5482.2 4524.7 4693.3 4857.0 5043.8 5070.9 3858.6 3969.6 3979.1 4005.5 4022.3 1233.5 1248.6 1251.9 1258.9 1263.0 902.8 943.6 950.5 968.3 1005.1 5996.6 6018.8 6164.8 6194.1 6219.1 417.0 465.6 470.5 477.7 484.9 3953.9 3976.4 4026.2 4057.5 4122.8 10420.3 10814.0 10888.7 10898.9 10916.3 10554.9 10564.4 10689.6 10717.8 10728.3 8320.0 8410.0 8414.6 8418.9 8420.2 5931.7 5939.0 5960.9 5963.2 6152.4 9346.7 9552.5 9663.8 9673.4 9676.2 9463.0 9855.9 9874.9 9926.6 10022.6 6977.5 7163.7 7351.3 7537.4 7618.1 8373.4 8379.6 8434.1 8441.4 8485.3 7382.8 7534.1 7555.8 7621.5 7687.6 6430.2 7310.2 7394.8 7415.0 7503.0 7070.6 7145.2 7150.5 7154.9 7161.9 4937.6 4979.2 5011.7 5029.8 5060.9 4940.1 5003.8 5007.4 5103.9 5243.5 09:43:54 INFO - PROCESS | 1658 | 09:43:54 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:5865.25 Median:6632.97 stddev:1875.82 (28.3%) stddev-sans-first:1834.03 09:43:54 INFO - PROCESS | 1658 | Values: 302.7 332.9 340.2 341.9 344.8 6620.6 6741.1 6758.6 6773.1 6802.8 5375.9 6515.5 6761.9 6777.9 6781.1 4994.2 5053.1 5054.5 5067.1 5072.0 4793.0 4851.2 5059.9 5063.4 5074.0 4959.2 4961.9 4973.8 4983.8 5010.1 3866.3 4489.3 5012.6 5033.7 5041.3 4286.9 4289.2 4294.6 4294.9 4298.3 6230.3 6436.8 6443.5 6444.7 6448.0 5053.6 5714.4 5896.4 5903.8 5910.6 7158.5 7168.2 7185.5 7192.1 7198.5 4264.9 4463.8 4788.2 4788.6 4803.5 7532.2 7533.3 7534.7 7542.8 7552.2 4341.8 4765.0 4878.5 4878.5 4885.6 4747.5 4934.6 4940.2 4950.4 4950.7 5772.0 5914.8 5926.5 5936.9 5938.9 5954.3 7178.9 7190.6 7192.2 7213.7 1631.2 1675.0 1682.9 1700.0 1730.3 1109.6 1111.9 1119.1 1122.3 1128.7 4727.8 6609.1 6614.7 6645.4 6675.5 6125.4 7422.5 7423.0 7437.8 7453.1 5356.3 6653.0 6659.8 6660.3 6667.5 3901.3 3943.3 3944.4 3950.7 3954.8 7483.3 7845.4 7871.7 7894.3 7896.2 6148.5 7633.3 7659.8 7672.4 7674.2 7812.8 7823.6 7829.3 7832.0 7835.1 7198.1 7426.3 7430.9 7431.3 7447.1 7332.5 7382.5 7402.4 7402.9 7432.2 7923.1 7928.4 7940.4 7942.3 7946.1 4692.8 4719.8 4723.9 4728.0 4741.1 6779.9 7243.7 7498.5 7502.4 7513.1 7132.7 7160.9 7183.4 7184.8 7194.1 7144.6 7180.8 7190.6 7203.1 7208.9 7021.1 7024.6 7031.1 7033.8 7052.7 5823.8 6982.1 7188.9 7190.3 7210.6 7128.3 7155.4 7160.0 7181.2 7188.9 09:43:54 INFO - PROCESS | 1658 | 09:43:54 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:18793.42 Median:633.84 stddev:26546.32 (4188.2%) stddev-sans-first:26586.05 09:43:54 INFO - PROCESS | 1658 | Values: 706.6 731.9 760.4 773.3 781.1 15302.8 15594.5 15640.0 15645.5 15660.9 14270.8 14442.7 14465.9 14470.2 14475.9 742.1 764.0 907.0 942.0 944.8 919.6 932.5 934.5 936.1 936.5 980.6 993.3 994.7 997.2 1000.8 788.2 806.5 806.8 808.1 977.6 756.5 758.7 759.4 760.0 760.6 15237.6 15296.0 15303.6 15305.4 15317.3 12710.3 12735.7 12802.4 12822.9 13047.5 9997.8 10105.6 10213.4 10480.4 10512.0 2861.3 3549.6 3596.0 3626.1 3804.2 81682.6 81979.6 84387.2 84526.0 84540.7 9613.9 9700.6 9752.5 9896.2 10378.4 21876.8 22105.6 22128.0 22139.0 22146.2 7775.1 7795.2 7863.8 7886.1 8094.3 4278.5 4333.2 4376.2 4390.3 4616.7 3706.9 3765.0 3768.9 3771.3 3785.7 654.7 666.7 669.3 674.3 692.1 612.8 615.1 617.4 624.4 625.6 7423.8 7593.4 7924.0 7935.6 8140.6 529.1 532.5 567.6 596.4 642.1 3534.7 3801.9 3926.5 3989.2 4045.2 82833.8 88790.7 92610.0 94523.5 96140.5 83816.2 83895.0 85991.0 86594.1 87213.3 71753.6 71847.3 72737.0 73294.6 75761.2 7650.7 7720.7 7869.9 7986.4 8190.3 52122.2 52298.0 52450.0 52808.9 52906.0 52326.0 68928.7 70107.0 72715.3 73449.6 8068.4 10054.4 10116.7 10154.2 10920.3 11927.5 12047.5 12116.6 12414.2 12526.3 11781.9 11784.9 11810.4 11868.3 12030.3 11953.8 12043.3 12053.5 12141.3 12259.0 11699.7 11749.8 11892.5 12077.5 12108.3 9556.8 9606.6 9869.9 9999.4 10063.9 9204.1 9258.5 9495.4 9586.8 9591.8 09:43:54 INFO - PROCESS | 1658 | -------- Summary: end -------- 09:43:54 INFO - PROCESS | 1658 | 09:43:54 INFO - TEST-INFO | 1658: exit 0 09:43:54 INFO - TEST-OK | dromaeo_css | took 1113413ms 09:43:54 INFO - TEST-START | kraken 09:43:54 INFO - operating with platform_type : mac_ 09:43:54 INFO - Initialising browser for kraken test... 09:43:55 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmp32l2vy/profile http://localhost:49274/getInfo.html) 09:43:57 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 09:43:57 INFO - PROCESS | 1669 | colorDepth:24 09:43:57 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 09:43:57 INFO - PROCESS | 1669 | __metrics 09:43:57 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:43:57 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:43:57 INFO - TEST-INFO | 1669: exit 0 09:43:57 INFO - Browser initialized. 09:43:57 INFO - Running cycle 1/1 for kraken test... 09:43:57 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmp32l2vy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:09 INFO - PROCESS | 1672 | RSS: Main: 161128448 09:44:09 INFO - PROCESS | 1672 | 09:44:12 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:13 INFO - PROCESS | 1672 | RSS: Main: 223916032 09:44:13 INFO - PROCESS | 1672 | 09:44:15 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 09:44:16 INFO - PROCESS | 1672 | RSS: Main: 239243264 09:44:16 INFO - PROCESS | 1672 | 09:44:19 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 09:44:20 INFO - PROCESS | 1672 | RSS: Main: 326524928 09:44:20 INFO - PROCESS | 1672 | 09:44:22 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 09:44:22 INFO - PROCESS | 1672 | RSS: Main: 230330368 09:44:22 INFO - PROCESS | 1672 | 09:44:24 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:44:25 INFO - PROCESS | 1672 | RSS: Main: 230940672 09:44:25 INFO - PROCESS | 1672 | 09:44:28 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 09:44:29 INFO - PROCESS | 1672 | RSS: Main: 268738560 09:44:29 INFO - PROCESS | 1672 | 09:44:31 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 09:44:32 INFO - PROCESS | 1672 | RSS: Main: 270708736 09:44:32 INFO - PROCESS | 1672 | 09:44:35 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 09:44:36 INFO - PROCESS | 1672 | RSS: Main: 268959744 09:44:36 INFO - PROCESS | 1672 | 09:44:37 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:38 INFO - PROCESS | 1672 | RSS: Main: 260476928 09:44:38 INFO - PROCESS | 1672 | 09:44:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:40 INFO - PROCESS | 1672 | RSS: Main: 267546624 09:44:40 INFO - PROCESS | 1672 | 09:44:42 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:44:43 INFO - PROCESS | 1672 | RSS: Main: 270876672 09:44:43 INFO - PROCESS | 1672 | 09:44:46 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:44:46 INFO - PROCESS | 1672 | RSS: Main: 277975040 09:44:46 INFO - PROCESS | 1672 | 09:44:49 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:44:50 INFO - PROCESS | 1672 | RSS: Main: 274866176 09:44:50 INFO - PROCESS | 1672 | 09:44:51 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 09:44:52 INFO - PROCESS | 1672 | RSS: Main: 336474112 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | __start_tp_report 09:44:52 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 09:44:52 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 09:44:52 INFO - PROCESS | 1672 | |i|pagename|runs| 09:44:52 INFO - PROCESS | 1672 | |0;ai-astar;113;111;117;111;110;110;112;113;114;133 09:44:52 INFO - PROCESS | 1672 | |1;audio-beat-detection;157;119;144;161;118;141;132;116;167;119 09:44:52 INFO - PROCESS | 1672 | |2;audio-dft;185;184;186;184;184;185;184;185;181;185 09:44:52 INFO - PROCESS | 1672 | |3;audio-fft;69;78;91;150;59;73;81;89;144;55 09:44:52 INFO - PROCESS | 1672 | |4;audio-oscillator;91;91;136;80;86;90;123;80;76;155 09:44:52 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;92;104;134;72;128;129;134;86;94;85 09:44:52 INFO - PROCESS | 1672 | |6;imaging-darkroom;94;94;94;94;95;94;93;94;93;93 09:44:52 INFO - PROCESS | 1672 | |7;imaging-desaturate;87;85;86;84;85;84;106;131;85;85 09:44:52 INFO - PROCESS | 1672 | |8;json-parse-financial;59;62;62;62;61;62;63;77;59;56 09:44:52 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;60;63;64;62;64;74;68;65;66;66 09:44:52 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;79;80;78;79;80;79;78;79;79;82 09:44:52 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;135;139;145;127;123;124;127;125;150;124 09:44:52 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;166;216;174;163;161;166;172;161;160;162 09:44:52 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;66;68;68;65;70;78;95;96;77;66 09:44:52 INFO - PROCESS | 1672 | __end_tp_report 09:44:52 INFO - PROCESS | 1672 | __start_cc_report 09:44:52 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1952 09:44:52 INFO - PROCESS | 1672 | __end_cc_report 09:44:52 INFO - PROCESS | 1672 | __startTimestamp1466700292184__endTimestamp 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | ------- Summary: start ------- 09:44:52 INFO - PROCESS | 1672 | Number of tests: 14 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:114.40 Median:113.00 stddev:6.87 (6.1%) stddev-sans-first:7.26 09:44:52 INFO - PROCESS | 1672 | Values: 113.0 111.0 117.0 111.0 110.0 110.0 112.0 113.0 114.0 133.0 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:142.50 stddev:19.48 (13.7%) stddev-sans-first:19.32 09:44:52 INFO - PROCESS | 1672 | Values: 157.0 119.0 144.0 161.0 118.0 141.0 132.0 116.0 167.0 119.0 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:1.34 (0.7%) stddev-sans-first:1.39 09:44:52 INFO - PROCESS | 1672 | Values: 185.0 184.0 186.0 184.0 184.0 185.0 184.0 185.0 181.0 185.0 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:88.90 Median:75.50 stddev:32.74 (43.4%) stddev-sans-first:33.92 09:44:52 INFO - PROCESS | 1672 | Values: 69.0 78.0 91.0 150.0 59.0 73.0 81.0 89.0 144.0 55.0 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:83.00 stddev:27.24 (32.8%) stddev-sans-first:28.66 09:44:52 INFO - PROCESS | 1672 | Values: 91.0 91.0 136.0 80.0 86.0 90.0 123.0 80.0 76.0 155.0 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:105.80 Median:78.50 stddev:23.38 (29.8%) stddev-sans-first:24.26 09:44:52 INFO - PROCESS | 1672 | Values: 92.0 104.0 134.0 72.0 128.0 129.0 134.0 86.0 94.0 85.0 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 09:44:52 INFO - PROCESS | 1672 | Values: 94.0 94.0 94.0 94.0 95.0 94.0 93.0 94.0 93.0 93.0 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:91.80 Median:85.00 stddev:15.28 (18.0%) stddev-sans-first:16.11 09:44:52 INFO - PROCESS | 1672 | Values: 87.0 85.0 86.0 84.0 85.0 84.0 106.0 131.0 85.0 85.0 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:62.00 stddev:5.58 (9.0%) stddev-sans-first:5.79 09:44:52 INFO - PROCESS | 1672 | Values: 59.0 62.0 62.0 62.0 61.0 62.0 63.0 77.0 59.0 56.0 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.50 stddev:3.82 (5.8%) stddev-sans-first:3.56 09:44:52 INFO - PROCESS | 1672 | Values: 60.0 63.0 64.0 62.0 64.0 74.0 68.0 65.0 66.0 66.0 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.00 stddev:1.16 (1.5%) stddev-sans-first:1.22 09:44:52 INFO - PROCESS | 1672 | Values: 79.0 80.0 78.0 79.0 80.0 79.0 78.0 79.0 79.0 82.0 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:131.00 stddev:9.77 (7.5%) stddev-sans-first:10.30 09:44:52 INFO - PROCESS | 1672 | Values: 135.0 139.0 145.0 127.0 123.0 124.0 127.0 125.0 150.0 124.0 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:166.00 stddev:16.81 (10.1%) stddev-sans-first:17.76 09:44:52 INFO - PROCESS | 1672 | Values: 166.0 216.0 174.0 163.0 161.0 166.0 172.0 161.0 160.0 162.0 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:73.50 stddev:11.73 (16.0%) stddev-sans-first:11.99 09:44:52 INFO - PROCESS | 1672 | Values: 66.0 68.0 68.0 65.0 70.0 78.0 95.0 96.0 77.0 66.0 09:44:52 INFO - PROCESS | 1672 | -------- Summary: end -------- 09:44:52 INFO - PROCESS | 1672 | 09:44:52 INFO - TEST-INFO | 1672: exit 0 09:44:52 INFO - TEST-OK | kraken | took 57928ms 09:44:52 INFO - SUITE-END | took 1171s 09:44:53 INFO - Completed test suite (00:19:31) 09:44:53 INFO - javascript benchmark 09:44:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3537.2041290709594, 3585.6952159066477, 3590.658887405697, 3608.8556457741684, 3663.9633603663974, 5779.0, 5838.41615838416, 5853.7365818538165, 5855.941440585603, 5891.998360278758, 5832.358440571545, 5864.530837532998, 5880.941190588103, 5886.764529418829, 5894.4989675877605, 5247.606429517801, 5247.842564723064, 5283.07546179419, 5331.866703332409, 5389.461053894618, 5348.518633323, 5380.784768609271, 5392.622516423852, 5395.81114660987, 5398.676079435247, 5302.946970530284, 5357.008953343625, 5378.515933565978, 5380.838574842742, 5389.164679474688, 5352.839414817562, 5362.222477740745, 5368.114261146906, 5368.892622147535, 5401.189821526763, 5118.795248190105, 5283.154695248781, 5287.735613219324, 5289.285946397225, 5315.229291752674, 5721.056025755745, 5722.198892155102, 5753.367129615739, 5792.652440853562, 5807.128930660392, 6179.412955769195, 6196.690165491753, 6211.937880621226, 6214.65819379934, 6215.502759779207, 6106.794380079898, 6210.130581718563, 6210.243556585193, 6241.34465881085, 6245.594036387621, 5906.645601263938, 5998.730057147439, 6004.519638428916, 6024.337322894478, 6046.6069705469445, 6256.468200203034, 6300.842478938063, 6308.116863639094, 6314.968425157845, 6331.715072821734, 6142.539309551712, 6207.5654704171175, 6210.7515699372425, 6212.782552610637, 6220.25356957159, 6164.291106522717, 6241.375862413723, 6259.96870015647, 6266.905996410058, 6299.307076221612, 6151.661658608819, 6166.260048794174, 6199.0, 6210.347913469111, 6218.253809542884, 6133.334663918993, 6180.938190618126, 6215.564910456315, 6223.813285601439, 6239.407256310643, 4993.600511959107, 5001.624878134082, 5039.143345631178, 5053.115704751727, 5089.9745501272255, 4406.691531592758, 4526.932096018562, 4541.250693635513, 4544.318352247189, 4603.8849028773875, 5748.913766293509, 5836.620619659709, 5841.182234487175, 5877.882442351129, 5903.144044113579, 6229.906551401733, 6240.875182496325, 6271.3415091414745, 6273.466755325849, 6280.183576135073, 5850.239468869105, 5864.9413505864395, 5880.0591905295805, 5910.139623692285, 5910.911336329958, 5385.084535628953, 5417.51242388187, 5475.835724928259, 5491.203775452537, 5502.9174562381595, 6371.52213583983, 6415.1981002374705, 6419.1334169887405, 6421.293657697556, 6443.613383197023, 6206.72069756853, 6233.781817636361, 6250.781222657185, 6255.96872015637, 6284.151639528788, 6281.905771413524, 6367.395097465734, 6424.421802037652, 6427.55007149495, 6440.066190402459, 6172.876542469216, 6242.687865606792, 6244.0, 6250.968745156427, 6252.093446450148, 5815.156802263733, 6111.938880611315, 6261.624302541862, 6266.843328916813, 6287.559870808999, 6074.271087469532, 6086.452219300284, 6134.171886795404, 6165.260168779775, 6197.504199664107, 6204.3795620437595, 6212.099245609452, 6217.440430361289, 6228.937710623017, 6241.563090583615, 5789.681567513827, 6068.180795592715, 6075.513958883191, 6077.726502307495, 6129.264488261437, 6030.638161710312, 6098.054801505774, 6115.419458243266, 6127.754889804358, 6141.938580614136, 6117.724373814389, 6123.648682309606, 6147.016477363601, 6148.047052706837, 6158.952977993662], "value": 5792.952312661535, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.1491129104724, 554.6893739505874, 567.3872218004554, 569.4078158714937, 611.2451122863263, 33009.33981320372, 33556.0, 33588.4961725574, 33627.15932101692, 33672.98981030567, 34978.95063148109, 35528.64471355286, 39432.80283598578, 40714.7964260179, 40946.38580421296, 9837.262205334593, 9995.450250236234, 10002.349847259904, 10015.69952901414, 10018.148457381096, 9868.45723485208, 9992.45041522716, 9996.750081247954, 10001.399916005063, 10001.749956251115, 9335.113164249386, 12099.0, 12336.62990110298, 12347.259164450117, 12364.134510584263, 10134.239932005092, 11945.402729863472, 12070.577529786504, 12073.637790866289, 12081.456334464881, 11718.589849355318, 11851.822222666668, 11864.050875929992, 11865.466054027589, 11870.762584748256, 40558.797206014075, 41042.38436423456, 41077.79461102705, 41162.588374116174, 41226.79386603048, 3336.616289126733, 3378.3918894598964, 3878.6703130233964, 3918.0596656802445, 3985.880423587268, 28708.569371459445, 29295.560566591517, 29665.70334296651, 29818.403631927456, 29996.250093747833, 2753.600727894444, 2784.7076057013924, 2833.9858300708365, 2896.5075937090533, 2910.4179164167253, 360711.0, 362114.0, 363463.0, 364034.0, 364246.3575364239, 37173.62826371756, 38013.04967375782, 38069.048273792825, 38188.61811381906, 60869.69565152234, 35640.821795891374, 35811.64188358135, 35873.64126358755, 35936.46095308573, 35968.46047309293, 16010.679786404207, 16121.677566448605, 16125.354985800672, 16129.596760080856, 16198.838011619968, 13526.0, 13570.796438053438, 13584.388702508411, 13593.048486605843, 13880.958928080232, 7855.410844186709, 8182.1817818217705, 8351.791205219919, 8482.279006284534, 8485.575721214038, 3532.152283451953, 3607.8917632470543, 3608.855645774192, 3616.5840928293055, 3627.1294889226397, 979.5934687104772, 1012.8757079641592, 1016.6899095775859, 1020.8107554698693, 1160.988390116105, 28929.710702892702, 29426.0, 29426.0, 29962.250943726147, 30276.24309392239, 910.2217603948661, 1099.725068732817, 1149.4769879704713, 1173.9530418783324, 1258.5595041735319, 11743.471543780379, 14729.92635036818, 15299.137612295395, 15323.693526129415, 15597.220138993005, 624692.0, 625963.0, 627366.0, 627835.0, 630200.0, 53637.731811340695, 53788.0, 53817.46182538203, 54046.45953540493, 54522.0, 1556.3229994952005, 1571.772093046479, 1591.7373633350599, 1594.003747657714, 1595.1705113340997, 25551.105711300017, 25856.48287034211, 26193.0, 26285.605715913895, 26433.942642294092, 49908.0, 50104.0, 50168.0, 50232.49767502278, 50240.492785216506, 424610.0, 439275.0, 439536.0, 612447.0, 826767.0, 27039.594406084318, 27123.186304410898, 27809.44381112407, 27861.721382785912, 27861.860690696416, 46912.0, 47151.52848471471, 47268.0, 47435.57768089512, 48827.02345953132, 34060.31879362449, 36966.890993270245, 38410.80794596121, 38491.037724057125, 38525.229495410495, 30130.69869301279, 38025.619743802206, 38266.808665956494, 38571.80714096524, 38682.806585968014, 37961.21297953937, 38029.61970380261, 38436.42345364766, 38536.229275414895, 38854.805725971186, 32627.694892204046, 33671.82148624786, 33680.15799605029, 33839.83080084584, 33857.15357116092, 21402.357929262147, 25004.624930626418, 25297.62053569235, 25717.228483144787, 25898.4472514858], "value": 18679.27193238361, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.59771722570497, 413.78483188741876, 416.2382839403891, 416.3255526047802, 426.9786510674467, 20169.798302016974, 20350.389488315337, 20835.791642083575, 20857.061432235547, 21545.353639390803, 21465.141394344206, 21553.245636402728, 21838.89080554599, 21880.23419180329, 21911.0140043698, 5635.295588051484, 6168.876622467548, 6194.690265486708, 6196.16351792509, 6200.914839903022, 6004.0, 6118.938810611881, 6133.570650054498, 6143.201383820097, 6150.415710507517, 5249.895002099975, 5808.4481974212595, 6085.695715214244, 6151.415615516541, 6161.568690191689, 5789.478946894799, 6016.639001659914, 6089.634621922699, 6098.359672234418, 6102.5117990560875, 5339.145736682112, 5359.222912677679, 5366.221897824794, 5369.087255166631, 5376.1398176291605, 25480.980760769547, 25951.35121621956, 26314.342141446425, 26356.341091472674, 26359.20922372332, 2069.182672844218, 2194.6049711052005, 2452.288836237507, 2461.310832966772, 2937.9276564053966, 9798.853017204749, 9800.90199098007, 9928.255380846393, 9994.350367226107, 10193.898061019368, 1602.2789744614854, 1818.7180986947044, 1834.3121329501437, 1845.474039898636, 1874.6250749849949, 94644.0, 102589.46115808269, 104408.47795761049, 108100.0, 110324.0, 10168.28821982454, 10813.945930270298, 11300.982911538002, 11576.131790115774, 11870.821937670942, 14867.033642813183, 14867.107973521623, 14901.882358823132, 14914.17972011528, 14915.925420373045, 8760.824783504295, 8877.422967507091, 8926.776830579287, 9015.549222538846, 9118.86321705175, 7329.047223860864, 8201.71294004707, 9045.728628141167, 9060.592273347715, 9107.271418286522, 4585.885352866205, 4662.6269898408045, 4685.149366000411, 4711.434627844681, 4712.717236965725, 1817.7275906865248, 1834.9082545872652, 1953.7948515405678, 1972.723818665388, 1995.4013795861183, 937.6952490440634, 950.8383574792302, 979.5738853598707, 1029.9227557933184, 1103.569607852938, 19379.90310048469, 20259.0, 20273.79726202719, 20441.795582044288, 20581.69127463089, 998.4957596413765, 1008.2639673038723, 1034.4103860799423, 1047.4448542272455, 1066.3015724700333, 10364.481775911325, 10662.413567253876, 10887.18346124028, 10903.454827258605, 10928.617498387519, 645397.0, 648801.0, 656823.0, 657182.0, 668469.0, 100483.0, 116737.0, 124177.0, 125868.37065814795, 129568.0, 1041.3959903256093, 1047.1361127070197, 1060.5015642647943, 1065.989340106589, 1070.1652710885521, 17488.650226995134, 17707.645847083244, 17956.0, 18060.458186254433, 18228.0, 39208.0, 46868.737349759955, 50844.0, 51544.0, 51693.0, 70455.0, 74152.0, 74732.62633686796, 76769.61615192112, 76991.84512232209, 7452.50949810051, 8127.552984585905, 8268.917310826815, 8487.0, 8597.88227530417, 10374.962503749564, 12040.337781422106, 12521.499140034297, 12891.355432228163, 13072.281024543361, 9713.465759383302, 10940.343579384944, 11188.944055279671, 11303.321800691985, 11511.079113671054, 8751.868721969047, 11055.83416248773, 11134.55461781552, 11342.092632589538, 11487.25332853362, 11440.656780296604, 11458.656240312805, 11576.768464630492, 11771.0, 11808.527658893549, 8112.269895709414, 8339.583020849055, 8363.330933525425, 8378.49729016261, 8583.141685831368, 10326.122279606017, 11354.432278385882, 11583.420828958688, 11589.826152607886, 11656.53373865036], "value": 9644.257019420565, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.3413076396419, 1592.0368177252758, 1597.400974634512, 1630.9429169979046, 1983.4743792894885, 7179.174394944583, 7804.0, 8764.693235736759, 8770.210681038705, 8786.297096232302, 8518.744437666865, 8763.86854197186, 8766.123387661246, 8767.342449316295, 8778.078301778318, 2500.9749902501017, 2533.037445770614, 2534.847909125449, 2536.353229926366, 2539.0224763466013, 2470.1601455505124, 2514.4091138582417, 2518.0809004713333, 2518.244526642009, 2526.6462695222685, 2486.751324867517, 2514.673092497982, 2547.757962993522, 2551.4514379408424, 2553.221267513408, 2488.713797913236, 2523.671922650053, 2525.1414519063514, 2526.6715327007555, 2527.9747202527924, 2482.937926551833, 2519.5464816333238, 2527.747225277476, 2527.8356906801, 2531.6455696202547, 8636.438631488996, 8910.415979365976, 8974.967878693968, 8979.281657467387, 9020.8646870297, 5411.242426060355, 5491.752871120809, 5504.6421982571, 5530.806421775259, 5542.695151766651, 3540.5574303212097, 3598.226381328027, 3629.909252268688, 3645.0887278180453, 3670.72469564781, 1063.6330465989222, 1065.6749691344137, 1066.2163309967168, 1073.9463026848625, 1081.1836115326248, 11660.650180494598, 11759.294442333487, 11963.0, 11993.220440671328, 12020.0, 4596.655250856199, 4596.839110631112, 4710.505396933341, 4740.336352910595, 4746.786394612251, 9449.952750236342, 9453.432794032242, 9464.432134071978, 9464.763380915394, 9465.432074075577, 5435.809746658848, 5464.808731694372, 5470.425605311465, 5471.644343117685, 5482.17767334903, 4524.6832721709825, 4693.342931989524, 4857.028594281158, 5043.798248070109, 5070.923936140961, 3858.6141385861188, 3969.563348031714, 3979.144483935968, 4005.539362973237, 4022.2759903217116, 1233.5004323249098, 1248.5630029489787, 1251.8810712982252, 1258.8929940955122, 1263.0, 902.8194361127801, 943.5895385507326, 950.4724877692947, 968.2834702320232, 1005.0652892809611, 5996.640201587831, 6018.8194354169445, 6164.845878853064, 6194.101855230966, 6219.098230756515, 416.9770662613585, 465.57167405986576, 470.4777696756598, 477.6680207255924, 484.9490803465656, 3953.940690889639, 3976.443297938291, 4026.154507553388, 4057.4928133983253, 4122.752634841919, 10420.270581059252, 10814.026737593655, 10888.727781805519, 10898.945505272422, 10916.290441121302, 10554.894451055392, 10564.36613803159, 10689.625863094754, 10717.78564428707, 10728.302660327054, 8319.958400207961, 8410.03284622264, 8414.579271036424, 8418.915810841936, 8420.15798420153, 5931.733072011683, 5938.970305148619, 5960.910586341295, 5963.194968679173, 6152.354002829818, 9346.672866449642, 9552.522373881417, 9663.758406039906, 9673.419594824332, 9676.22590192797, 9462.952685236529, 9855.901440985785, 9874.851877221703, 9926.553305101143, 10022.649207277711, 6977.476689248225, 7163.713451461883, 7351.301626345488, 7537.434692397982, 7618.085829700472, 8373.371997100363, 8379.622916968872, 8434.114417986268, 8441.409101362846, 8485.321174305916, 7382.778516644509, 7534.133574638768, 7555.773326800205, 7621.542766977407, 7687.577183254974, 6430.196225471816, 7310.159331676925, 7394.7781566553085, 7415.0, 7503.0, 7070.6111163884425, 7145.214026456982, 7150.463715221275, 7154.892676609959, 7161.892571611535, 4937.629677774253, 4979.153543897473, 5011.674241174312, 5029.84910452687, 5060.873478163076, 4940.11078005948, 5003.824866129814, 5007.37407824022, 5103.87240318995, 5243.501867322599], "value": 4567.86091065143, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.7109110799187, 332.8768355708388, 340.1699852360242, 341.90084875386134, 344.81207741780725, 6620.569662971916, 6741.089952856369, 6758.628275444848, 6773.119494465713, 6802.829929251765, 5375.892482150354, 6515.543911926167, 6761.898571521431, 6777.932220677804, 6781.118454600895, 4994.200927851544, 5053.140966035783, 5054.494550544934, 5067.062593420229, 5072.0, 4792.9760351198365, 4851.175300198975, 5059.949400506003, 5063.417706963691, 5074.0, 4959.156943319645, 4961.925571116418, 4973.751312434382, 4983.825566105187, 5010.0981823271795, 3866.2654095722005, 4489.304157855538, 5012.649114561982, 5033.697978121324, 5041.269015992697, 4286.935695964563, 4289.249381358281, 4294.592013758688, 4294.871153865389, 4298.333758267474, 6230.2523697156175, 6436.774712885073, 6443.484521238336, 6444.677766111722, 6448.0, 5053.620978426633, 5714.371419143932, 5896.351401345849, 5903.793367232126, 5910.556708246899, 7158.463115266324, 7168.247334029956, 7185.461090418187, 7192.136943566806, 7198.460115491359, 4264.850730224427, 4463.843765468226, 4788.209945359012, 4788.592969597588, 4803.495632958524, 7532.17146113927, 7533.322001019935, 7534.736284230025, 7542.811429714301, 7552.207018263058, 4341.804618792162, 4765.0231702500905, 4878.487758785347, 4878.512148785093, 4885.60915126789, 4747.548982846624, 4934.629902757236, 4940.2342636891335, 4950.43070046942, 4950.653454258239, 5772.047612144033, 5914.792982245601, 5926.496247818897, 5936.851578710567, 5938.940610593925, 5954.285485741739, 7178.892316615255, 7190.568565886064, 7192.208857025723, 7213.711451541984, 1631.2007116512823, 1674.9950029982158, 1682.87378446617, 1700.0, 1730.2732852202105, 1109.5949978257877, 1111.899929006377, 1119.054399032816, 1122.2537012886503, 1128.7403897103547, 4727.810887564528, 6609.074729537869, 6614.669266536654, 6645.368689974444, 6675.499337549703, 6125.387461253839, 7422.480426370103, 7422.96288518554, 7437.7768666939, 7453.068366454193, 5356.330458692663, 6652.966735166293, 6659.833504162435, 6660.301623086082, 6667.466602671775, 3901.3367727486398, 3943.3099207638547, 3944.4083387491532, 3950.664193543581, 3954.8220330085214, 7483.2516748325825, 7845.411594130463, 7871.685132594746, 7894.328982036591, 7896.170902055316, 6148.477379422709, 7633.313001829751, 7659.846803063908, 7672.424568157299, 7674.194209607911, 7812.765617031499, 7823.647935842901, 7829.295363417206, 7831.960840195762, 7835.0989636191425, 7198.136223653195, 7426.2945020223, 7430.888536671846, 7431.331180193809, 7447.143578488543, 7332.523385979895, 7382.52013619113, 7402.370798481974, 7402.888956665762, 7432.21961694036, 7923.088844782924, 7928.405369597188, 7940.364770818436, 7942.285194332538, 7946.086200087064, 4692.765361731968, 4719.834805781781, 4723.929141062956, 4727.976360118178, 4741.075490279362, 6779.864402712017, 7243.674034668347, 7498.512596681198, 7502.437317201341, 7513.1359893612935, 7132.679029443584, 7160.928390716234, 7183.389411899838, 7184.820379490555, 7194.100737407824, 7144.642767861482, 7180.820479488055, 7190.640467976685, 7203.135623725187, 7208.8918666219, 7021.0872586565465, 7024.613646249505, 7031.1211098612675, 7033.788986330418, 7052.682629281592, 5823.79616713413, 6982.092327997328, 7188.856222875409, 7190.280971902768, 7210.603416812126, 7128.322809333105, 7155.391791697764, 7159.964200178966, 7181.245969173162, 7188.892166617609], "value": 5243.913513053919, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.5760543673796, 731.9377852882504, 760.4220792197927, 773.2653978720214, 781.1368437876148, 15302.846971530282, 15594.45419410321, 15640.0, 15645.452409165682, 15660.921695391522, 14270.785938210935, 14442.711145777079, 14465.927670361634, 14470.204138772364, 14475.855241447582, 742.1391186223981, 764.0106062648855, 906.9682561110362, 942.006183476432, 944.7921457279422, 919.6045700348848, 932.4545141092469, 934.5374039850284, 936.1060187520901, 936.4755736787387, 980.6077568972397, 993.3046867192994, 994.7115336552428, 997.1574019953129, 1000.7948370584013, 788.2393490281877, 806.5241507510567, 806.753940048285, 808.127222599594, 977.613842532203, 756.4893696754668, 758.6851456645486, 759.4418102694515, 759.9962000190019, 760.5626764610371, 15237.6190595236, 15296.005759625588, 15303.617409564738, 15305.387784488606, 15317.31072101758, 12710.300933448656, 12735.745285094246, 12802.42389092493, 12822.935885320607, 13047.478100875953, 9997.800043999152, 10105.646302379455, 10213.387196768217, 10480.371177729361, 10512.0, 2861.2846788302923, 3549.6095429502734, 3596.0, 3626.12972886508, 3804.1821008483307, 81682.59158704228, 81979.59010204911, 84387.15612843854, 84526.0, 84540.73188902233, 9613.90386096144, 9700.611975521042, 9752.463614501128, 9896.208303335716, 10378.42918639467, 21876.781232187794, 22105.557888842453, 22128.00423980925, 22139.0, 22146.22488212905, 7775.066991960888, 7795.181505941908, 7863.764087077397, 7886.132525422199, 8094.31198348147, 4278.4865816102265, 4333.198358303724, 4376.168527979674, 4390.253656878338, 4616.699914505613, 3706.944395834065, 3764.9811750941617, 3768.9434658480145, 3771.321162190832, 3785.73499855013, 654.7119267522274, 666.6600033982606, 669.2972379002028, 674.305465370669, 692.1452006771633, 612.8284080457479, 615.0528186592686, 617.4042049422329, 624.4348864277836, 625.562106525434, 7423.777286681408, 7593.430492713069, 7924.049114106228, 7935.563544005136, 8140.5929703514585, 529.0767610519667, 532.5233915645475, 567.5658121537027, 596.4393470138057, 642.1235014205575, 3534.6642069003406, 3801.9354580717445, 3926.489556357655, 3989.1822176453757, 4045.1707399982934, 82833.75749363765, 88790.66813997795, 92610.0, 94523.52738236265, 96140.51929740446, 83816.16183838206, 83895.0, 85991.0, 86594.13405865987, 87213.25573488495, 71753.64123179455, 71847.2815271851, 72737.0, 73294.63352683203, 75761.24238757652, 7650.655720492702, 7720.652570634223, 7869.8819517708425, 7986.401019923645, 8190.262876341158, 52122.21816672677, 52297.95404091821, 52449.951000979, 52808.94382112413, 52906.0, 52326.0, 68928.6553567229, 70107.0, 72715.27284727085, 73449.6327518359, 8068.3545316373375, 10054.447005414773, 10116.696499105039, 10154.187664986932, 10920.2901811382, 11927.46326415296, 12047.457864396298, 12116.636500904988, 12414.193077449936, 12526.311052892179, 11781.882181178078, 11784.882151178379, 11810.350430726048, 11868.347240901488, 12030.338331391857, 11953.760924781282, 12043.277403355827, 12053.491650616412, 12141.332226727614, 12259.0, 11699.707507312385, 11749.823752643546, 11892.524299027942, 12077.51689932393, 12108.334041627795, 9556.808863822545, 9606.567704453457, 9869.851952220579, 9999.35004224723, 10063.949680251551, 9204.079592041011, 9258.49078300673, 9495.43027418357, 9586.765349568352, 9591.760205994906], "value": 7030.859964094897, "unit": "score"}], "name": "dromaeo_css", "value": 7484.395173783075, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 117.0, 111.0, 110.0, 110.0, 112.0, 113.0, 114.0, 133.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 119.0, 144.0, 161.0, 118.0, 141.0, 132.0, 116.0, 167.0, 119.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 186.0, 184.0, 184.0, 185.0, 184.0, 185.0, 181.0, 185.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 78.0, 91.0, 150.0, 59.0, 73.0, 81.0, 89.0, 144.0, 55.0], "value": 88.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 136.0, 80.0, 86.0, 90.0, 123.0, 80.0, 76.0, 155.0], "value": 100.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 104.0, 134.0, 72.0, 128.0, 129.0, 134.0, 86.0, 94.0, 85.0], "value": 105.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 93.0, 94.0, 93.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 84.0, 85.0, 84.0, 106.0, 131.0, 85.0, 85.0], "value": 91.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 62.0, 62.0, 61.0, 62.0, 63.0, 77.0, 59.0, 56.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 64.0, 62.0, 64.0, 74.0, 68.0, 65.0, 66.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 78.0, 79.0, 80.0, 79.0, 78.0, 79.0, 79.0, 82.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 145.0, 127.0, 123.0, 124.0, 127.0, 125.0, 150.0, 124.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 216.0, 174.0, 163.0, 161.0, 166.0, 172.0, 161.0, 160.0, 162.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 65.0, 70.0, 78.0, 95.0, 96.0, 77.0, 66.0], "value": 74.9, "unit": "score"}], "name": "kraken", "value": 1500.8999999999999, "alertThreshold": 2.0}]} 09:44:53 INFO - Return code: 0 09:44:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:44:53 ERROR - # TBPL SUCCESS # 09:44:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:44:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:44:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:44:53 INFO - 2016-06-23 09:44:53.486 screenresolution[1676:9980] starting screenresolution argv=screenresolution get 09:44:53 INFO - 2016-06-23 09:44:53.488 screenresolution[1676:9980] Display 0: 1600x1200x32@60 09:44:53 INFO - 2016-06-23 09:44:53.494 screenresolution[1677:9983] starting screenresolution argv=screenresolution list 09:44:53 INFO - Available Modes on Display 0 09:44:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:44:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:44:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:44:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:44:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:44:53 INFO - Intel Iris: 09:44:53 INFO - Chipset Model: Intel Iris 09:44:53 INFO - Type: GPU 09:44:53 INFO - Bus: Built-In 09:44:53 INFO - VRAM (Dynamic, Max): 1536 MB 09:44:53 INFO - Vendor: Intel (0x8086) 09:44:53 INFO - Device ID: 0x0a2e 09:44:53 INFO - Revision ID: 0x0009 09:44:53 INFO - Displays: 09:44:53 INFO - Display: 09:44:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:44:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:44:53 INFO - Display Serial Number: 1600x1200 60 09:44:53 INFO - Main Display: Yes 09:44:53 INFO - Mirror: Off 09:44:53 INFO - Online: Yes 09:44:53 INFO - Rotation: Supported 09:44:53 INFO - Return code: 0 09:44:53 INFO - Running post-action listener: _resource_record_post_action 09:44:53 INFO - Running post-run listener: _resource_record_post_run 09:44:54 INFO - Total resource usage - Wall time: 1195s; CPU: 52.0%; Read bytes: 38127104; Write bytes: 493719040; Read time: 415; Write time: 1730 09:44:54 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 189196800; Write bytes: 184705024; Read time: 17126; Write time: 336 09:44:54 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 36345344; Write bytes: 298225152; Read time: 389; Write time: 1354 09:44:54 INFO - Running post-run listener: _upload_blobber_files 09:44:54 INFO - Blob upload gear active. 09:44:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:44:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:44:55 INFO - (blobuploader) - INFO - Open directory for files ... 09:44:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:44:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:44:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:55 INFO - (blobuploader) - INFO - Done attempting. 09:44:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:44:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:44:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:56 INFO - (blobuploader) - INFO - Done attempting. 09:44:56 INFO - (blobuploader) - INFO - Iteration through files over. 09:44:56 INFO - Return code: 0 09:44:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:44:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:44:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ca05b7a1163aa7a3904d56c06de6ca511c0829baa11d9cf53d0b51785ca97313987fe1236c8cbae5c892fffdd98d864af7e35b3e7d4be6cafdd28a9758173b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6583873b625d7b6399b1b91f602acd6fe921e22dfce8eb219cc3553041f81cf565a5988df59e50f501d8d3b0b158928d2fd257c64885c680c97815617982a37"} 09:44:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:44:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:44:56 INFO - Contents: 09:44:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ca05b7a1163aa7a3904d56c06de6ca511c0829baa11d9cf53d0b51785ca97313987fe1236c8cbae5c892fffdd98d864af7e35b3e7d4be6cafdd28a9758173b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6583873b625d7b6399b1b91f602acd6fe921e22dfce8eb219cc3553041f81cf565a5988df59e50f501d8d3b0b158928d2fd257c64885c680c97815617982a37"} 09:44:56 INFO - Running post-run listener: copy_logs_to_upload_dir 09:44:56 INFO - Copying logs to upload dir... 09:44:56 INFO - mkdir: /builds/slave/test/build/upload/logs 09:44:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.232629 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-23 09:44:56.839122) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 09:44:56.842513) ========= 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.7NeIjTs2a7/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.6ljUllclmf/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ca05b7a1163aa7a3904d56c06de6ca511c0829baa11d9cf53d0b51785ca97313987fe1236c8cbae5c892fffdd98d864af7e35b3e7d4be6cafdd28a9758173b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6583873b625d7b6399b1b91f602acd6fe921e22dfce8eb219cc3553041f81cf565a5988df59e50f501d8d3b0b158928d2fd257c64885c680c97815617982a37"} build_url:https://queue.taskcluster.net/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010873 build_url: 'https://queue.taskcluster.net/v1/task/Mqq8Y-7GRGSS-_YuiDHyLA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ca05b7a1163aa7a3904d56c06de6ca511c0829baa11d9cf53d0b51785ca97313987fe1236c8cbae5c892fffdd98d864af7e35b3e7d4be6cafdd28a9758173b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6583873b625d7b6399b1b91f602acd6fe921e22dfce8eb219cc3553041f81cf565a5988df59e50f501d8d3b0b158928d2fd257c64885c680c97815617982a37"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 09:44:56.875048) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:44:56.875429) ========= 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.7NeIjTs2a7/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.6ljUllclmf/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.005208 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:44:56.924019) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 09:44:56.924374) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 09:44:56.924718) ========= ========= Total master_lag: 4.23 =========