builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0086 starttime: 1461171296.21 results: success (0) buildid: 20160420085143 builduid: a19590ffd5794bd8b87c1db960dec79d revision: 6a3291366533e40960df1f859d52734f13f3d7a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 09:54:56.210124) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 09:54:56.210531) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 09:54:56.210847) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 09:54:56.231033) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 09:54:56.231414) ========= 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.rXCVe0qBY8/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.H9PFf2TY3y/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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-04-20 09:54:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-04-20 09:54:56 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110247 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 09:54:56.365213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 09:54:56.365557) ========= 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.rXCVe0qBY8/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.H9PFf2TY3y/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.019986 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 09:54:56.414596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 09:54:56.414989) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6a3291366533e40960df1f859d52734f13f3d7a3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6a3291366533e40960df1f859d52734f13f3d7a3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rXCVe0qBY8/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.H9PFf2TY3y/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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-04-20 09:54:56,488 truncating revision to first 12 chars 2016-04-20 09:54:56,488 Setting DEBUG logging. 2016-04-20 09:54:56,488 attempt 1/10 2016-04-20 09:54:56,488 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6a3291366533?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 09:54:58,167 unpacking tar archive at: fx-team-6a3291366533/testing/mozharness/ program finished with exit code 0 elapsedTime=1.925293 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 09:54:58.367396) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 09:54:58.368035) ========= script_repo_revision: 6a3291366533e40960df1f859d52734f13f3d7a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 09:54:58.368490) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 09:54:58.368850) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 09:54:58.382572) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-20 09:54:58.382920) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rXCVe0qBY8/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.H9PFf2TY3y/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:54:58 INFO - MultiFileLogger online at 20160420 09:54:58 in /builds/slave/test 09:54:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:54:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:54:58 INFO - {'append_to_log': False, 09:54:58 INFO - 'base_work_dir': '/builds/slave/test', 09:54:58 INFO - 'blob_upload_branch': 'Fx-Team', 09:54:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:54:58 INFO - 'branch': 'Fx-Team', 09:54:58 INFO - 'buildbot_json_path': 'buildprops.json', 09:54:58 INFO - 'config_files': ('talos/mac_config.py',), 09:54:58 INFO - 'default_actions': ('clobber', 09:54:58 INFO - 'read-buildbot-config', 09:54:58 INFO - 'download-and-extract', 09:54:58 INFO - 'populate-webroot', 09:54:58 INFO - 'create-virtualenv', 09:54:58 INFO - 'install', 09:54:58 INFO - 'run-tests'), 09:54:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:54:58 INFO - 'download_minidump_stackwalk': True, 09:54:58 INFO - 'download_symbols': 'ondemand', 09:54:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:54:58 INFO - 'tooltool.py': '/tools/tooltool.py', 09:54:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:54:58 INFO - '/tools/misc-python/virtualenv.py')}, 09:54:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:54:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:54:58 INFO - 'installer_path': 'installer.exe', 09:54:58 INFO - 'log_level': 'info', 09:54:58 INFO - 'log_name': 'talos', 09:54:58 INFO - 'log_to_console': True, 09:54:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:54:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:54:58 INFO - 'opt_config_files': (), 09:54:58 INFO - 'pip_index': False, 09:54:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:54:58 INFO - 'cmd': ('bash', 09:54:58 INFO - '-c', 09:54:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:54:58 INFO - 'enabled': True, 09:54:58 INFO - 'halt_on_failure': False, 09:54:58 INFO - 'name': 'check_screen_resolution'},), 09:54:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:54:58 INFO - 'cmd': ('bash', 09:54:58 INFO - '-c', 09:54:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:54:58 INFO - 'enabled': True, 09:54:58 INFO - 'halt_on_failure': False, 09:54:58 INFO - 'name': 'check_screen_resolution'},), 09:54:58 INFO - 'run_cmd_checks_enabled': True, 09:54:58 INFO - 'sps_profile': False, 09:54:58 INFO - 'sps_profile_interval': 0, 09:54:58 INFO - 'suite': 'dromaeojs', 09:54:58 INFO - 'system_bits': '32', 09:54:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:54:58 INFO - 'title': 't-yosemite-r7-0086', 09:54:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:54:58 INFO - 'use_talos_json': True, 09:54:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:54:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:54:58 INFO - 'work_dir': 'build'} 09:54:58 INFO - ##### 09:54:58 INFO - ##### Running clobber step. 09:54:58 INFO - ##### 09:54:58 INFO - Running pre-action listener: _resource_record_pre_action 09:54:58 INFO - Running main action method: clobber 09:54:58 INFO - rmtree: /builds/slave/test/build 09:54:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:54:59 INFO - Running post-action listener: _resource_record_post_action 09:54:59 INFO - ##### 09:54:59 INFO - ##### Running read-buildbot-config step. 09:54:59 INFO - ##### 09:54:59 INFO - Running pre-action listener: _resource_record_pre_action 09:54:59 INFO - Running main action method: read_buildbot_config 09:54:59 INFO - Using buildbot properties: 09:54:59 INFO - { 09:54:59 INFO - "project": "", 09:54:59 INFO - "product": "firefox", 09:54:59 INFO - "script_repo_revision": "production", 09:54:59 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 09:54:59 INFO - "repository": "", 09:54:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 09:54:59 INFO - "buildid": "20160420085143", 09:54:59 INFO - "pgo_build": "False", 09:54:59 INFO - "basedir": "/builds/slave/test", 09:54:59 INFO - "buildnumber": 655, 09:54:59 INFO - "slavename": "t-yosemite-r7-0086", 09:54:59 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:54:59 INFO - "platform": "yosemite_r7", 09:54:59 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:54:59 INFO - "branch": "fx-team", 09:54:59 INFO - "repo_path": "integration/fx-team", 09:54:59 INFO - "revision": "6a3291366533e40960df1f859d52734f13f3d7a3", 09:54:59 INFO - "stage_platform": "macosx64", 09:54:59 INFO - "builduid": "a19590ffd5794bd8b87c1db960dec79d", 09:54:59 INFO - "slavebuilddir": "test" 09:54:59 INFO - } 09:54:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 09:54:59 INFO - Running post-action listener: _resource_record_post_action 09:54:59 INFO - ##### 09:54:59 INFO - ##### Running download-and-extract step. 09:54:59 INFO - ##### 09:54:59 INFO - Running pre-action listener: _resource_record_pre_action 09:54:59 INFO - Running main action method: download_and_extract 09:54:59 INFO - mkdir: /builds/slave/test/build/tests 09:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:59 INFO - https://queue.taskcluster.net/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:54:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:54:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:54:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:54:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 09:55:01 INFO - Downloaded 1199 bytes. 09:55:01 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:55:01 INFO - Using the following test package requirements: 09:55:01 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:55:01 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:01 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:55:01 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:01 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:55:01 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:01 INFO - u'jsshell-mac.zip'], 09:55:01 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:01 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:55:01 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:55:01 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:01 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:55:01 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:01 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:55:01 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:01 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:55:01 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:01 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:55:01 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:01 INFO - https://queue.taskcluster.net/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:55:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:55:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:55:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:55:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:55:02 INFO - Downloaded 18096076 bytes. 09:55:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:55:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:55:06 INFO - Return code: 0 09:55:06 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:55:06 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:55:06 INFO - https://queue.taskcluster.net/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:55:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:55:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:55:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:55:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:55:07 INFO - Downloaded 18096076 bytes. 09:55:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:55:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:55:11 INFO - Return code: 0 09:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:11 INFO - https://queue.taskcluster.net/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:55:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:55:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:55:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:55:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:55:12 INFO - Downloaded 10845952 bytes. 09:55:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:55:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:55:13 INFO - Return code: 0 09:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:13 INFO - https://queue.taskcluster.net/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:55:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:55:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:55:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:55:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 09:55:15 INFO - Downloaded 110037686 bytes. 09:55:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:55:15 INFO - mkdir: /builds/slave/test/properties 09:55:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:55:15 INFO - Writing to file /builds/slave/test/properties/build_url 09:55:15 INFO - Contents: 09:55:15 INFO - build_url:https://queue.taskcluster.net/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:55:17 INFO - Running post-action listener: _resource_record_post_action 09:55:17 INFO - Running post-action listener: set_extra_try_arguments 09:55:17 INFO - ##### 09:55:17 INFO - ##### Running populate-webroot step. 09:55:17 INFO - ##### 09:55:17 INFO - Running pre-action listener: _resource_record_pre_action 09:55:17 INFO - Running main action method: populate_webroot 09:55:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:55:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:55:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:55:17 INFO - '--tppagecycles', 09:55:17 INFO - '7'], 09:55:17 INFO - 'tests': ['tsvgm']}}, 09:55:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:55:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:55:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:55:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:55:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:55:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:55:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:17 INFO - 'talos_options': ['--disable-e10s'], 09:55:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:17 INFO - 'talos_options': ['--disable-e10s'], 09:55:17 INFO - 'tests': ['damp', 'tps']}, 09:55:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:17 INFO - 'tests': ['damp', 'tps']}, 09:55:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:55:17 INFO - 'tests': ['dromaeo_dom']}, 09:55:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:55:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:55:17 INFO - 'tests': ['a11yr', 09:55:17 INFO - 'ts_paint', 09:55:17 INFO - 'tpaint', 09:55:17 INFO - 'sessionrestore', 09:55:17 INFO - 'sessionrestore_no_auto_restore', 09:55:17 INFO - 'tabpaint']}, 09:55:17 INFO - 'other-e10s': {'tests': ['a11yr', 09:55:17 INFO - 'ts_paint', 09:55:17 INFO - 'tpaint', 09:55:17 INFO - 'sessionrestore', 09:55:17 INFO - 'sessionrestore_no_auto_restore', 09:55:17 INFO - 'tabpaint']}, 09:55:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:55:17 INFO - 'ts_paint', 09:55:17 INFO - 'tpaint', 09:55:17 INFO - 'sessionrestore', 09:55:17 INFO - 'sessionrestore_no_auto_restore', 09:55:17 INFO - 'tabpaint']}, 09:55:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:55:17 INFO - 'ts_paint', 09:55:17 INFO - 'tpaint', 09:55:17 INFO - 'sessionrestore', 09:55:17 INFO - 'sessionrestore_no_auto_restore', 09:55:17 INFO - 'tabpaint']}, 09:55:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:55:17 INFO - 'tests': ['a11yr', 09:55:17 INFO - 'ts_paint', 09:55:17 INFO - 'tpaint', 09:55:17 INFO - 'sessionrestore', 09:55:17 INFO - 'sessionrestore_no_auto_restore', 09:55:17 INFO - 'tabpaint']}, 09:55:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:55:17 INFO - 'tests': ['a11yr', 09:55:17 INFO - 'ts_paint', 09:55:17 INFO - 'tpaint', 09:55:17 INFO - 'sessionrestore', 09:55:17 INFO - 'sessionrestore_no_auto_restore', 09:55:17 INFO - 'tabpaint']}, 09:55:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:55:17 INFO - 'tests': ['tsvgx', 09:55:17 INFO - 'tsvgr_opacity', 09:55:17 INFO - 'tart', 09:55:17 INFO - 'tscrollx', 09:55:17 INFO - 'cart']}, 09:55:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:55:17 INFO - 'tsvgr_opacity', 09:55:17 INFO - 'tart', 09:55:17 INFO - 'tscrollx', 09:55:17 INFO - 'cart']}, 09:55:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:17 INFO - 'talos_options': ['--disable-e10s'], 09:55:17 INFO - 'tests': ['tp5o']}, 09:55:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:17 INFO - 'tests': ['tp5o']}, 09:55:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:17 INFO - 'talos_options': ['--disable-e10s', 09:55:17 INFO - '--xperf_path', 09:55:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:17 INFO - 'tests': ['tp5n']}, 09:55:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:17 INFO - 'talos_options': ['--xperf_path', 09:55:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:17 INFO - 'tests': ['tp5n']}}, 09:55:17 INFO - 'talos.zip': {'path': '', 09:55:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:55:17 INFO - Running post-action listener: _resource_record_post_action 09:55:17 INFO - ##### 09:55:17 INFO - ##### Running create-virtualenv step. 09:55:17 INFO - ##### 09:55:17 INFO - Running pre-action listener: _resource_record_pre_action 09:55:17 INFO - Running main action method: create_virtualenv 09:55:17 INFO - Creating virtualenv /builds/slave/test/build/venv 09:55:17 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:55:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:55:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:55:17 INFO - Using real prefix '/tools/python27' 09:55:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:55:17 INFO - Installing distribute.............................................................................................................................................................................................done. 09:55:20 INFO - Installing pip.................done. 09:55:20 INFO - Return code: 0 09:55:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:55: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:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55: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:55:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:20 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 0x107be9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bf9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd528dabb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a88e00>, '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 0x1078b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83b20>, '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.rXCVe0qBY8/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.H9PFf2TY3y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:55:20 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:55:20 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:55:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXCVe0qBY8/Render', 09:55:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:20 INFO - 'HOME': '/Users/cltbld', 09:55:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:20 INFO - 'LOGNAME': 'cltbld', 09:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:20 INFO - 'MOZ_NO_REMOTE': '1', 09:55:20 INFO - 'NO_EM_RESTART': '1', 09:55:20 INFO - 'PAGER': '/bin/cat', 09:55:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:20 INFO - 'PWD': '/builds/slave/test', 09:55:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:20 INFO - 'SHELL': '/bin/bash', 09:55:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9PFf2TY3y/Listeners', 09:55:20 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:55:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:20 INFO - 'USER': 'cltbld', 09:55:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:20 INFO - 'XPC_FLAGS': '0x0', 09:55:20 INFO - 'XPC_SERVICE_NAME': '0', 09:55:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:21 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:55:21 INFO - Cleaning up... 09:55:21 INFO - Return code: 0 09:55:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:55:21 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:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:21 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:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:21 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 0x107be9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bf9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd528dabb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a88e00>, '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 0x1078b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83b20>, '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.rXCVe0qBY8/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.H9PFf2TY3y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:55:21 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:55:21 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:55:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXCVe0qBY8/Render', 09:55:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:21 INFO - 'HOME': '/Users/cltbld', 09:55:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:21 INFO - 'LOGNAME': 'cltbld', 09:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:21 INFO - 'MOZ_NO_REMOTE': '1', 09:55:21 INFO - 'NO_EM_RESTART': '1', 09:55:21 INFO - 'PAGER': '/bin/cat', 09:55:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:21 INFO - 'PWD': '/builds/slave/test', 09:55:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:21 INFO - 'SHELL': '/bin/bash', 09:55:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9PFf2TY3y/Listeners', 09:55:21 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:55:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:21 INFO - 'USER': 'cltbld', 09:55:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:21 INFO - 'XPC_FLAGS': '0x0', 09:55:21 INFO - 'XPC_SERVICE_NAME': '0', 09:55:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:21 INFO - Downloading/unpacking psutil>=0.7.1 09:55:21 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:55:21 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:55:21 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:55:21 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:55:21 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:55:21 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:55:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:55:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:55:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:55:24 INFO - Installing collected packages: psutil 09:55:24 INFO - Running setup.py install for psutil 09:55:24 INFO - building 'psutil._psutil_osx' extension 09:55:24 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:55:24 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:55:24 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:55:24 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:55:24 INFO - building 'psutil._psutil_posix' extension 09:55:24 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:55:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:55:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:55:24 INFO - ^ 09:55:24 INFO - 1 warning generated. 09:55:24 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:55:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:55:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:55:25 INFO - Successfully installed psutil 09:55:25 INFO - Cleaning up... 09:55:25 INFO - Return code: 0 09:55:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:25 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 0x107be9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bf9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd528dabb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a88e00>, '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 0x1078b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83b20>, '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.rXCVe0qBY8/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.H9PFf2TY3y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:55:25 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:55:25 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:55:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXCVe0qBY8/Render', 09:55:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:25 INFO - 'HOME': '/Users/cltbld', 09:55:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:25 INFO - 'LOGNAME': 'cltbld', 09:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:25 INFO - 'MOZ_NO_REMOTE': '1', 09:55:25 INFO - 'NO_EM_RESTART': '1', 09:55:25 INFO - 'PAGER': '/bin/cat', 09:55:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:25 INFO - 'PWD': '/builds/slave/test', 09:55:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:25 INFO - 'SHELL': '/bin/bash', 09:55:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9PFf2TY3y/Listeners', 09:55:25 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:55:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:25 INFO - 'USER': 'cltbld', 09:55:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:25 INFO - 'XPC_FLAGS': '0x0', 09:55:25 INFO - 'XPC_SERVICE_NAME': '0', 09:55:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:55:25 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:55:25 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:55:25 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:55:25 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:55:25 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:55:25 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:55:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:55:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:55:28 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:55:28 INFO - Installing collected packages: mozsystemmonitor 09:55:28 INFO - Running setup.py install for mozsystemmonitor 09:55:28 INFO - Successfully installed mozsystemmonitor 09:55:28 INFO - Cleaning up... 09:55:28 INFO - Return code: 0 09:55:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107be9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bf9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd528dabb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a88e00>, '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 0x1078b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83b20>, '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.rXCVe0qBY8/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.H9PFf2TY3y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:55:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:55:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:55:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXCVe0qBY8/Render', 09:55:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:28 INFO - 'HOME': '/Users/cltbld', 09:55:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:28 INFO - 'LOGNAME': 'cltbld', 09:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:28 INFO - 'MOZ_NO_REMOTE': '1', 09:55:28 INFO - 'NO_EM_RESTART': '1', 09:55:28 INFO - 'PAGER': '/bin/cat', 09:55:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:28 INFO - 'PWD': '/builds/slave/test', 09:55:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:28 INFO - 'SHELL': '/bin/bash', 09:55:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9PFf2TY3y/Listeners', 09:55:28 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:55:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:28 INFO - 'USER': 'cltbld', 09:55:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:28 INFO - 'XPC_FLAGS': '0x0', 09:55:28 INFO - 'XPC_SERVICE_NAME': '0', 09:55:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:28 INFO - Downloading/unpacking blobuploader==1.2.4 09:55:28 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:55:28 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:55:28 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:55:28 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:55:28 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:55:28 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:55:30 INFO - Downloading blobuploader-1.2.4.tar.gz 09:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:55:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:55:31 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:55:31 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:55:31 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:55:31 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:55:31 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:55:31 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:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:55:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:55:31 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:55:31 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:55:31 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:55:31 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:55:31 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:55:31 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:55:32 INFO - Downloading docopt-0.6.1.tar.gz 09:55:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:55:32 INFO - Installing collected packages: blobuploader, requests, docopt 09:55:32 INFO - Running setup.py install for blobuploader 09:55:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:55:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:55:32 INFO - Running setup.py install for requests 09:55:32 INFO - Running setup.py install for docopt 09:55:32 INFO - Successfully installed blobuploader requests docopt 09:55:32 INFO - Cleaning up... 09:55:33 INFO - Return code: 0 09:55:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:33 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 0x107be9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bf9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd528dabb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a88e00>, '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 0x1078b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83b20>, '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.rXCVe0qBY8/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.H9PFf2TY3y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:55:33 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:55:33 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:55:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXCVe0qBY8/Render', 09:55:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:33 INFO - 'HOME': '/Users/cltbld', 09:55:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:33 INFO - 'LOGNAME': 'cltbld', 09:55:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:33 INFO - 'MOZ_NO_REMOTE': '1', 09:55:33 INFO - 'NO_EM_RESTART': '1', 09:55:33 INFO - 'PAGER': '/bin/cat', 09:55:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:33 INFO - 'PWD': '/builds/slave/test', 09:55:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:33 INFO - 'SHELL': '/bin/bash', 09:55:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9PFf2TY3y/Listeners', 09:55:33 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:55:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:33 INFO - 'USER': 'cltbld', 09:55:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:33 INFO - 'XPC_FLAGS': '0x0', 09:55:33 INFO - 'XPC_SERVICE_NAME': '0', 09:55:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:55:33 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-udX1wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:55:33 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-5817kT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:55:33 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-fVVwNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:55:33 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-1okOeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:55:33 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-vr3Zst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:55:33 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-yEGPUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:55:33 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-lJ0Isw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:55:34 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-HzGrpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:55:34 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-oEsSqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:55:34 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-h4IFko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:55:34 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-W3xTuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:55:34 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-s30FDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:55:34 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-RmchKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:55:34 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-wOyTmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:34 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-JdtLVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:55:34 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-BHq58Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:55:35 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-A6YKLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:55:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:55:35 INFO - Running setup.py install for manifestparser 09:55:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:55:35 INFO - Running setup.py install for mozcrash 09:55:35 INFO - Running setup.py install for mozdebug 09:55:35 INFO - Running setup.py install for mozdevice 09:55:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:55:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:55:35 INFO - Running setup.py install for mozfile 09:55:35 INFO - Running setup.py install for mozhttpd 09:55:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:55:36 INFO - Running setup.py install for mozinfo 09:55:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:55:36 INFO - Running setup.py install for mozInstall 09:55:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:55:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:55:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:55:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:55:36 INFO - Running setup.py install for mozleak 09:55:36 INFO - Running setup.py install for mozlog 09:55:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:55:36 INFO - Running setup.py install for moznetwork 09:55:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:55:36 INFO - Running setup.py install for mozprocess 09:55:36 INFO - Running setup.py install for mozprofile 09:55:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:55:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:55:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:55:37 INFO - Running setup.py install for mozrunner 09:55:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:55:37 INFO - Running setup.py install for mozscreenshot 09:55:37 INFO - Running setup.py install for moztest 09:55:37 INFO - Running setup.py install for mozversion 09:55:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:55:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:55:37 INFO - Cleaning up... 09:55:37 INFO - Return code: 0 09:55:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:37 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 0x107be9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bf9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd528dabb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a88e00>, '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 0x1078b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83b20>, '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.rXCVe0qBY8/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.H9PFf2TY3y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:55:37 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:55:37 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:55:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXCVe0qBY8/Render', 09:55:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:37 INFO - 'HOME': '/Users/cltbld', 09:55:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:37 INFO - 'LOGNAME': 'cltbld', 09:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:37 INFO - 'MOZ_NO_REMOTE': '1', 09:55:37 INFO - 'NO_EM_RESTART': '1', 09:55:37 INFO - 'PAGER': '/bin/cat', 09:55:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:37 INFO - 'PWD': '/builds/slave/test', 09:55:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:37 INFO - 'SHELL': '/bin/bash', 09:55:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9PFf2TY3y/Listeners', 09:55:37 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:55:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:37 INFO - 'USER': 'cltbld', 09:55:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:37 INFO - 'XPC_FLAGS': '0x0', 09:55:37 INFO - 'XPC_SERVICE_NAME': '0', 09:55:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:55:37 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-BDIkS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:55:38 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:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:55:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-A4BehS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:55:38 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:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:55:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Iiyu3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:55:38 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:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:55:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-AeTYbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:55:38 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:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:55:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-1UcAMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:55:38 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:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:55:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-0GgROG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:55:38 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:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:55:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-koObQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:55:38 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:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:55:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-sVfHSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:55:38 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:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:55:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-FjML9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:55:38 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:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:55:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-mJRi2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:55:39 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:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:55:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-oksFk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:55:39 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:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:55:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-1SkjLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:55:39 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:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:55:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ItT2EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:55:39 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:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:55:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-LEfJcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:55:39 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:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-TYvadY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:39 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:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:55:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-vHac8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:55:39 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:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:55:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-H2yFFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:55:39 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:55:39 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:55:39 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:55:39 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:55:39 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:55:39 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:55:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:42 INFO - Downloading blessings-1.6.tar.gz 09:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:55:42 INFO - Installing collected packages: blessings 09:55:42 INFO - Running setup.py install for blessings 09:55:42 INFO - Successfully installed blessings 09:55:42 INFO - Cleaning up... 09:55:43 INFO - Return code: 0 09:55:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:55:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:55:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:55:43 INFO - Reading from file tmpfile_stdout 09:55:43 INFO - Current package versions: 09:55:43 INFO - blessings == 1.6 09:55:43 INFO - blobuploader == 1.2.4 09:55:43 INFO - docopt == 0.6.1 09:55:43 INFO - manifestparser == 1.1 09:55:43 INFO - mozInstall == 1.12 09:55:43 INFO - mozcrash == 0.17 09:55:43 INFO - mozdebug == 0.1 09:55:43 INFO - mozdevice == 0.48 09:55:43 INFO - mozfile == 1.2 09:55:43 INFO - mozhttpd == 0.7 09:55:43 INFO - mozinfo == 0.9 09:55:43 INFO - mozleak == 0.1 09:55:43 INFO - mozlog == 3.1 09:55:43 INFO - moznetwork == 0.27 09:55:43 INFO - mozprocess == 0.22 09:55:43 INFO - mozprofile == 0.28 09:55:43 INFO - mozrunner == 6.11 09:55:43 INFO - mozscreenshot == 0.1 09:55:43 INFO - mozsystemmonitor == 0.0 09:55:43 INFO - moztest == 0.7 09:55:43 INFO - mozversion == 1.4 09:55:43 INFO - psutil == 3.1.1 09:55:43 INFO - requests == 1.2.3 09:55:43 INFO - wsgiref == 0.1.2 09:55:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:43 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 0x107be9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bf9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd528dabb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a88e00>, '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 0x1078b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83b20>, '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.rXCVe0qBY8/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.H9PFf2TY3y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:55:43 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:55:43 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:55:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXCVe0qBY8/Render', 09:55:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:43 INFO - 'HOME': '/Users/cltbld', 09:55:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:43 INFO - 'LOGNAME': 'cltbld', 09:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:43 INFO - 'MOZ_NO_REMOTE': '1', 09:55:43 INFO - 'NO_EM_RESTART': '1', 09:55:43 INFO - 'PAGER': '/bin/cat', 09:55:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:43 INFO - 'PWD': '/builds/slave/test', 09:55:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:43 INFO - 'SHELL': '/bin/bash', 09:55:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9PFf2TY3y/Listeners', 09:55:43 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:55:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:43 INFO - 'USER': 'cltbld', 09:55:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:43 INFO - 'XPC_FLAGS': '0x0', 09:55:43 INFO - 'XPC_SERVICE_NAME': '0', 09:55:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:44 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:55:44 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:55:44 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:55:44 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:55:44 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:55:44 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:55:44 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:55:44 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:55:44 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:55:44 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:55:44 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:55:44 INFO - Cleaning up... 09:55:44 INFO - Return code: 0 09:55:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:55: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:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55: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:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:44 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 0x107be9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bf9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd528dabb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a88e00>, '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 0x1078b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83b20>, '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.rXCVe0qBY8/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.H9PFf2TY3y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:55:44 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:55:44 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:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXCVe0qBY8/Render', 09:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:44 INFO - 'HOME': '/Users/cltbld', 09:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:44 INFO - 'LOGNAME': 'cltbld', 09:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:44 INFO - 'MOZ_NO_REMOTE': '1', 09:55:44 INFO - 'NO_EM_RESTART': '1', 09:55:44 INFO - 'PAGER': '/bin/cat', 09:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:44 INFO - 'PWD': '/builds/slave/test', 09:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:44 INFO - 'SHELL': '/bin/bash', 09:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9PFf2TY3y/Listeners', 09:55:44 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:44 INFO - 'USER': 'cltbld', 09:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:44 INFO - 'XPC_FLAGS': '0x0', 09:55:44 INFO - 'XPC_SERVICE_NAME': '0', 09:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:44 INFO - Downloading/unpacking jsonschema 09:55:44 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:55:44 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:55:44 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:55:44 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:55:44 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:55:44 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:55:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:55:46 INFO - Downloading/unpacking functools32 (from jsonschema) 09:55: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:55: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:55: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:55: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:55: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:55: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:55:47 INFO - Downloading functools32-3.2.3-2.tar.gz 09:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:55:47 INFO - warning: no files found matching '*.txt' 09:55:47 INFO - no previously-included directories found matching 'build' 09:55:47 INFO - no previously-included directories found matching 'dist' 09:55:47 INFO - no previously-included directories found matching '.git*' 09:55:47 INFO - Installing collected packages: jsonschema, functools32 09:55:47 INFO - Running setup.py install for functools32 09:55:47 INFO - warning: no files found matching '*.txt' 09:55:47 INFO - no previously-included directories found matching 'build' 09:55:47 INFO - no previously-included directories found matching 'dist' 09:55:47 INFO - no previously-included directories found matching '.git*' 09:55:47 INFO - Successfully installed jsonschema functools32 09:55:47 INFO - Cleaning up... 09:55:47 INFO - Return code: 0 09:55:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107be9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bf9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd528dabb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a88e00>, '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 0x1078b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83b20>, '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.rXCVe0qBY8/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.H9PFf2TY3y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:55:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:55:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:55:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXCVe0qBY8/Render', 09:55:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:47 INFO - 'HOME': '/Users/cltbld', 09:55:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:47 INFO - 'LOGNAME': 'cltbld', 09:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:47 INFO - 'MOZ_NO_REMOTE': '1', 09:55:47 INFO - 'NO_EM_RESTART': '1', 09:55:47 INFO - 'PAGER': '/bin/cat', 09:55:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:47 INFO - 'PWD': '/builds/slave/test', 09:55:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:47 INFO - 'SHELL': '/bin/bash', 09:55:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9PFf2TY3y/Listeners', 09:55:47 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:55:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:47 INFO - 'USER': 'cltbld', 09:55:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:47 INFO - 'XPC_FLAGS': '0x0', 09:55:47 INFO - 'XPC_SERVICE_NAME': '0', 09:55:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:47 INFO - Downloading/unpacking flake8 09:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:55:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:55:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:55:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:55:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:55:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:55:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:55:51 INFO - no previously-included directories found matching 'docs/_build' 09:55:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:55:51 INFO - Running setup.py install for pep8 09:55:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:55:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:55:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:55:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:55:51 INFO - no previously-included directories found matching 'docs/_build' 09:55:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:55:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:55:51 INFO - Cleaning up... 09:55:51 INFO - Return code: 0 09:55:51 INFO - Running post-action listener: _resource_record_post_action 09:55:51 INFO - Running post-action listener: _start_resource_monitoring 09:55:51 INFO - Starting resource monitoring. 09:55:51 INFO - ##### 09:55:51 INFO - ##### Running install step. 09:55:51 INFO - ##### 09:55:51 INFO - Running pre-action listener: _resource_record_pre_action 09:55:51 INFO - Running main action method: install 09:55:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:55:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:55:52 INFO - Reading from file tmpfile_stdout 09:55:52 INFO - Detecting whether we're running mozinstall >=1.0... 09:55:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:55:52 INFO - Reading from file tmpfile_stdout 09:55:52 INFO - Output received: 09:55:52 INFO - Usage: mozinstall [options] installer 09:55:52 INFO - Options: 09:55:52 INFO - -h, --help show this help message and exit 09:55:52 INFO - -d DEST, --destination=DEST 09:55:52 INFO - Directory to install application into. [default: 09:55:52 INFO - "/builds/slave/test"] 09:55:52 INFO - --app=APP Application being installed. [default: firefox] 09:55:52 INFO - mkdir: /builds/slave/test/build/application 09:55:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:56:25 INFO - Reading from file tmpfile_stdout 09:56:25 INFO - Output received: 09:56:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:56:25 INFO - Running post-action listener: _resource_record_post_action 09:56:25 INFO - ##### 09:56:25 INFO - ##### Running run-tests step. 09:56:25 INFO - ##### 09:56:25 INFO - Running pre-action listener: _resource_record_pre_action 09:56:25 INFO - Running main action method: run_tests 09:56:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:56:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:56:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:56:25 INFO - 2016-04-20 09:56:25.775 screenresolution[2017:15836] starting screenresolution argv=screenresolution get 09:56:25 INFO - 2016-04-20 09:56:25.777 screenresolution[2017:15836] Display 0: 1600x1200x32@60 09:56:25 INFO - 2016-04-20 09:56:25.783 screenresolution[2018:15838] starting screenresolution argv=screenresolution list 09:56:25 INFO - Available Modes on Display 0 09:56:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:56:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:56:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:56:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:56:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:56:26 INFO - Intel Iris: 09:56:26 INFO - Chipset Model: Intel Iris 09:56:26 INFO - Type: GPU 09:56:26 INFO - Bus: Built-In 09:56:26 INFO - VRAM (Dynamic, Max): 1536 MB 09:56:26 INFO - Vendor: Intel (0x8086) 09:56:26 INFO - Device ID: 0x0a2e 09:56:26 INFO - Revision ID: 0x0009 09:56:26 INFO - Displays: 09:56:26 INFO - Display: 09:56:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:56:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:56:26 INFO - Display Serial Number: 1600x1200 60 09:56:26 INFO - Main Display: Yes 09:56:26 INFO - Mirror: Off 09:56:26 INFO - Online: Yes 09:56:26 INFO - Rotation: Supported 09:56:26 INFO - Return code: 0 09:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:56:26 INFO - Python 2.7.3 09:56:26 INFO - Return code: 0 09:56:26 INFO - grabbing minidump binary from tooltool 09:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:26 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 0x107a88e00>, '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 0x1078b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:56:26 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:56:26 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:56:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:56:26 INFO - Return code: 0 09:56:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:56:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:56:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:56:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:56:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:56:27 INFO - Return code: 0 09:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0086 --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:56:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXCVe0qBY8/Render', 09:56:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:27 INFO - 'HOME': '/Users/cltbld', 09:56:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:27 INFO - 'LOGNAME': 'cltbld', 09:56:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:56:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:27 INFO - 'MOZ_NO_REMOTE': '1', 09:56:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:56:27 INFO - 'NO_EM_RESTART': '1', 09:56:27 INFO - 'PAGER': '/bin/cat', 09:56:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:27 INFO - 'PWD': '/builds/slave/test', 09:56:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:56:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:27 INFO - 'SHELL': '/bin/bash', 09:56:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9PFf2TY3y/Listeners', 09:56:27 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:56:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:27 INFO - 'USER': 'cltbld', 09:56:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:27 INFO - 'XPC_FLAGS': '0x0', 09:56:27 INFO - 'XPC_SERVICE_NAME': '0', 09:56:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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:56:27 INFO - mozversion application_buildid: 20160420085143 09:56:27 INFO - mozversion application_changeset: 6a3291366533e40960df1f859d52734f13f3d7a3 09:56:27 INFO - mozversion application_display_name: Nightly 09:56:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:56:27 INFO - mozversion application_name: Firefox 09:56:27 INFO - mozversion application_remotingname: firefox 09:56:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:56:27 INFO - mozversion application_vendor: Mozilla 09:56:27 INFO - mozversion application_version: 48.0a1 09:56:27 INFO - mozversion platform_buildid: 20160420085143 09:56:27 INFO - mozversion platform_changeset: 6a3291366533e40960df1f859d52734f13f3d7a3 09:56:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:56:27 INFO - mozversion platform_version: 48.0a1 09:56:27 INFO - using testdate: 1461171387 09:56:27 INFO - actual date: 1461171387 09:56:27 INFO - starting webserver on 'localhost:51403' 09:56:27 INFO - SUITE-START | Running 2 tests 09:56:27 INFO - TEST-START | dromaeo_css 09:56:27 INFO - operating with platform_type : mac_ 09:56:27 INFO - Initialising browser for dromaeo_css test... 09:56:27 INFO - TEST-INFO | started process 2036 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpJzzvH5/profile http://localhost:51403/getInfo.html) 09:56:29 INFO - PROCESS | 2036 | __metrics Screen width/height:1600/1200 09:56:29 INFO - PROCESS | 2036 | colorDepth:24 09:56:29 INFO - PROCESS | 2036 | Browser inner width/height: 1024/689 09:56:29 INFO - PROCESS | 2036 | __metrics 09:56:29 INFO - PROCESS | 2036 | 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:56:29 ERROR - PROCESS | 2036 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:56:30 INFO - TEST-INFO | 2036: exit 0 09:56:30 INFO - Browser initialized. 09:56:30 INFO - Running cycle 1/1 for dromaeo_css test... 09:56:30 INFO - TEST-INFO | started process 2038 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpJzzvH5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:42 INFO - PROCESS | 2038 | RSS: Main: 237817856 09:56:42 INFO - PROCESS | 2038 | 09:57:33 INFO - PROCESS | 2038 | 1461171453798 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:59:44 INFO - PROCESS | 2038 | Cycle 1(1): loaded http://localhost:51403/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51403/tests/dromaeo/cssquery-ext.html) 09:59:45 INFO - PROCESS | 2038 | RSS: Main: 376438784 09:59:45 INFO - PROCESS | 2038 | 10:02:49 INFO - PROCESS | 2038 | Cycle 1(1): loaded http://localhost:51403/tests/dromaeo/cssquery-ext.html (next: http://localhost:51403/tests/dromaeo/cssquery-jquery.html) 10:02:49 INFO - PROCESS | 2038 | RSS: Main: 378650624 10:02:49 INFO - PROCESS | 2038 | 10:05:51 INFO - PROCESS | 2038 | Cycle 1(1): loaded http://localhost:51403/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51403/tests/dromaeo/cssquery-mootools.html) 10:05:52 INFO - PROCESS | 2038 | RSS: Main: 361697280 10:05:52 INFO - PROCESS | 2038 | 10:08:54 INFO - PROCESS | 2038 | Cycle 1(1): loaded http://localhost:51403/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51403/tests/dromaeo/cssquery-prototype.html) 10:08:55 INFO - PROCESS | 2038 | RSS: Main: 375304192 10:08:55 INFO - PROCESS | 2038 | 10:11:58 INFO - PROCESS | 2038 | Cycle 1(1): loaded http://localhost:51403/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51403/tests/dromaeo/cssquery-yui.html) 10:11:59 INFO - PROCESS | 2038 | RSS: Main: 346034176 10:11:59 INFO - PROCESS | 2038 | 10:15:02 INFO - PROCESS | 2038 | Cycle 1(1): loaded http://localhost:51403/tests/dromaeo/cssquery-yui.html (next: http://localhost:51403/tests/dromaeo/cssquery-dojo.html) 10:15:02 INFO - PROCESS | 2038 | RSS: Main: 382943232 10:15:02 INFO - PROCESS | 2038 | 10:15:02 INFO - PROCESS | 2038 | __start_tp_report 10:15:02 INFO - PROCESS | 2038 | _x_x_mozilla_page_load 10:15:02 INFO - PROCESS | 2038 | _x_x_mozilla_page_load_details 10:15:02 INFO - PROCESS | 2038 | |i|pagename|runs| 10:15:02 INFO - PROCESS | 2038 | |0;dojo.html;2926.4878646236903;3391.6269210386854;3402.693757561819;3434.8969530914064;3452.5684289463816;5634.549236061105;5644.238027866237;5674.858128546788;5675.489205971462;5701.401352857953;4655.697379670319;5745.6265342752695;5796.710164491779;5908.202392676987;5935.465808077272;5162.432132465426;5189.8183563575285;5197.272381866542;5239.21411788231;5239.397469291042;5255.763490642911;5270.104082305998;5307.2569840222395;5315.309009828717;5390.9191362129595;5154.433012368637;5182.222666600041;5253.553447956928;5277.788888444457;5278.4721527846905;5215.113430716788;5254.97372513135;5284.894302113936;5302.840914772563;5304.416514183436;4269.231538323101;5158.226266060084;5204.219367094966;5228.320318358589;5301.867453313659;5738.081906894877;5748.65508069513;5754.165645981309;5756.107803290455;5756.165356023395;6126.785562505291;6176.69116544171;6208.00671892495;6225;6295.370462953714;6246.750129994794;6309.022101574264;6309.495240380758;6326.683665816737;6334.936650633527;5833.2416785817995;5847.619904706181;5849.532037436995;5853.326867410217;5858.8242352729485;6226.875462490725;6255;6282.905756413657;6291.465225455888;6318.652474113968;6125.540694081788;6141.170941922873;6141.84645383869;6144.324124346318;6155.661438620829;5869.914065897822;5947.226860508106;6062.181605483203;6110.694465276719;6263.96868015657;6042.939570604238;6131.540134489931;6132.967444181115;6189.257289125334;6237.220347456568;6266.279377871512;6332.366763323631;6334.3665633436285;6335.493160547145;6346.238451385863;4908.950910490849;4915.803367865316;4932.7533623319405;4933.777979990838;4951.10880041596;4326;4437.755923424178;4481.014176881081;4500.639948804153;4513.435820522434;5750.482456578928;5817.854553636108;5819.94180058194;5852.356240813507;5856.677882716492;6274.2784579773;6306.905396419057;6319.526035547352;6338.207724034496;6346.555741098171;5618.213450116987;5706;5707.571932105026;5721.5708821838525;5809.5352371811;5336.146216605324;5360.70516121617;5361.919571206435;5362.1420572708175;5363.5440987516495;6283.528735344776;6291.087792270096;6314.810555683337;6324.462420694109;6332.746690132435;6239.688015599293;6317.684115794284;6318.399752023551;6336.968315158395;6354.586951848115;6196.659183744938;6250.4687101595055;6263.4362907338555;6330.272018717907;6333.334999824952;6236.844078898064;6246;6261.56169068179;6274.1843560336865;6275.152854364785;6270.4670103039925;6303.432691057827;6304.495640348853;6321.52588555851;6332.778352757631;5974.40255974399;6094.908576371269;6112.510999119971;6174.907376389448;6175.536834737502;6131.774283661862;6193.535484838745;6202.627842329474;6204.038374052029;6205.069239614094;5954.46409823118;6020.367861374668;6053.576249662481;6064.363241859542;6066.484348830399;5969.403059693996;6070.848228794315;6145;6195.2255968004;6211.0372892201785;6033.12519684652;6063;6074.757009719562;6082.178905847654;6142.723577438936 10:15:02 INFO - PROCESS | 2038 | |1;ext.html;485.3520550065662;495.84876612633155;532.8241680245518;582.6154737873005;607.019663243861;29883.85058074712;37304.44043339349;38226.61773382262;38421;38423.80788096062;40501.987450313754;40869.79565102178;41118.58881411185;41246;41381.37927931076;8412.789680258013;9340.673076442308;9576.664816731416;9577.76055598612;9604.2316614671;8517.190866867637;8646.135386461367;8652.178043085929;8654.740357789276;11273.267237629569;11295.604653837117;11401.144914131432;11409.42952852354;11423.657290281264;11435.256708313975;11274.210805243636;11342.149338799623;11361;11367.943160284229;11374.999999999958;8446;11193.776124477465;11256.887431125666;11551.53793848245;11558.826617600742;32770;35718.821405892806;37411.25177496462;38105.0473738156;38153.618463815284;3167.33485967947;3263.7552183586326;3314.93370132596;3423;3635.327464419091;18582.9779362135;22952.311430657108;28072.57891131635;28974.710252897414;29045;2173.7717539658424;2708.3499960009653;2712.443948990452;2717.062613398374;2899.043315705812;336289;336721;337509.12454377185;338935;338936.3053184743;45429.54570454253;53586.39240822782;53880.6895448371;54457.72771136119;54473;57063.429365706645;60001;60157.09764353538;60306;60547.78904421975;16052.357905683875;16511.33954641825;16514.83485165133;16521.091339976178;16546.91726541384;12812.974962003018;12897.484100636057;12897.968162546973;12906.29015404143;12936.353182340845;11637.767244655059;14398.784018239734;15433.38266469351;15841.68316633684;15882.047077175406;5551.667599776106;6616.96691516549;6632.535722499379;6681.665916704243;6707.865842683119;835.3275613131487;900.4822227219244;990.7473594233569;1015.7765291635828;1080.3140006096185;24348.904299306574;27157.10996601217;28973.855130724212;29596.852015739783;29848.850755746083;1097.2703152403562;1102.8125218712837;1118.4519585403257;1162.3200427749691;1283.768921594122;15003.474878379422;15206.467773628092;15210.619734506505;15397.461088861835;15428.768568471482;568465.157674209;583633;585157;586718;587127;58400.70799645974;58730.706346467996;58989;59082.70458647679;59099;1328.2030781531005;1447.7538818401108;1485.9108453492825;1490.5169356490362;1493.0966765106955;26079;26703.19890403291;28110.718892811627;28564.57153142746;28695.713042869305;43237.702868913984;56329;58332;58468.122978156214;58481.70759146177;420836;423601;426884;428823.8558807311;429817;20590.691139632618;22892.542149157256;23563.0574777007;25152.24543263705;25582.976680932556;41507;42130.847278298315;42468.57531424646;43142.64177890584;43774;35322.823385882904;36501.63498365089;36880.81559592185;37532.624673752915;37954.86135415942;36532;36558.45162322514;36984;37235.81382093072;37372.43941340937;36002.21092415596;36486.817565912;36584.634153658124;37037;37672.811635941645;31586.842065789522;32176;32264.032079037668;33225.833870830495;34710.82644586862;23466.64800028035;23777.405564861016;23944.64083038721;24185.51628967446;24286.51426971486 10:15:02 INFO - PROCESS | 2038 | |2;jquery.html;390.3072047116368;393.77948348924593;396.2510854485024;398.2373754260591;406.3153586207241;19725.60548789025;19946.70079948802;20473.692894606593;20543.486412839688;21254;20165.495862603442;20532.17871285147;21611.351659450203;21637.783622163774;21697;4890.339804126433;6128.6322820630685;6136.9079463808075;6143.600665956698;6153.292371377282;5216.660917040399;5584.832455026356;5954.166416701665;6009.639421634694;6019.729112189962;5956.076808094752;5961.850953726148;5966;5966.582339236255;5966.985612445873;5710.486056254937;6121.357257487966;6142.662153581551;6150.538709596798;6155.446009859112;5664.801731939362;5892.438503796455;5935.575461889159;5949.315828679714;5961.986462301419;13671.38478768448;13722.931385343009;18537.165827537792;24807.00771969119;26037.21888343353;2315.8263130265127;2322.8257880659016;2398;2399.616061430163;2767.5986981887513;9263.722088337361;9875.358101723437;10035.548400322003;10062.64780732678;10142.492875356204;1750.5011071844463;1775.254393154878;1792.9103544822706;1801.189464740872;1817.9363722269788;113158;117045.41477292644;117638;118867;122536;11492.42537873103;11552.306861588331;11618.244814087057;11681;11771.352575608424;15003.924980375028;15099.320530576151;15111.31999060045;15115;15117.017393869362;8399.758122148276;8593.097724738938;8602.741917742478;8712.69505567302;8744.300455963508;6830.453563714891;8389.286910612544;8407.369447291478;8559.229669329665;8606;4470.5976462117915;4564.406627138451;4576.336431217454;4617.930731039037;4622.699524530894;1600.5438450041681;1883.7645294338208;1900.1354383755358;1913.0817207740363;1924.162989099746;864.6368525219423;879.5865943006777;915.1031988651159;984.2863923655435;1049.490996866519;20034.69947950782;20668.483287917923;20733.58532829335;20847.304777611072;20869;966.3380584299778;974.8147851908257;1005.2661557063385;1005.6832097889142;1023.6212601337553;10409.42748148844;10832.29566170254;10849.349039057524;10852.023317901427;10887.965643263877;592834;595628;599981;616249;617696;84196.57901710452;120497;127915.72084279225;131914;132388;983.6508039645822;990.9801803964025;1012.6202673997251;1012.8278192707257;1016.5577973581368;17614.647707046042;17890.373836916166;18025.819741802414;18053.368132115313;18195.00971520295;47051;47902.97018813114;48313.549832026874;48368.27447588359;48502;72706.63646681733;72808.27191728014;73241.63379183284;73290;75707.8643820332;7607.353374962969;7668.194839541768;7779.4554381192775;7823.295903368724;8157.8368432632205;10638;11766.294022358687;11972.281663100242;12060;12151.635450936486;10018.599256029676;10223.284370094021;10520.894791051991;10554.683359499228;10640.84038739435;8478.618462169094;10002.949985250027;10074.597016119273;10247.128994035591;10307.536160872629;9364.250859931326;9681.467519286225;10220.846687299547;10431.165506759593;10794.892051079389;7677.347425468898;7714.845703086019;7753.612319384121;7820.3743700504965;8069.636866341146;8821.779455513664;9618.807623847624;9827.754306142404;10536.998985096403;10573.947130264607 10:15:02 INFO - PROCESS | 2038 | |3;mootools.html;1419.687668712884;1477.0177831741892;1555.6655319106394;1826.5251034730966;1983.305842954967;7927.682892684285;8621;8860.512671803048;8873.245774109193;8889.866652000224;7550.5847178405165;8728.301735861132;8735.388522803407;8752.081031491698;8756.91243087569;2042.7242322286525;2442.8412153210074;2469.1975108089855;2471.4439251168433;2476.3809047738064;2427.4659574893494;2449.6815413996155;2465.7657522535333;2471.9011239550396;2475.591527397977;2435.4398488347692;2449.448874003344;2453.1659235859806;2461.7538246175327;2463.864487453189;2393.892274847636;2423.987880060597;2424.842385244953;2435.0259896041634;2446.694163229596;2399.5200959808108;2426.2236084452984;2428.793552548018;2432.4891772727747;2435.099013365066;8518.233358997659;8633.827323453495;8664.306855451548;8699.99950005751;8701.17338852808;5246.554042906358;5473.562115030788;5507.118860982224;5523.337199536081;5523.696196709179;3449.5688038995127;3549.7515173937836;3646.708263338953;3669.2294618130227;3677.595464498903;1022.2639699416409;1048.5386429970788;1053.1311667873958;1058.830587106067;1060.093619954935;11678.299302041905;11681.065514758799;11704.005159561448;11709.94145029278;11785.233959792586;4525.230710779176;4600.631949444037;4750.548697873696;4756.904861902743;4781.378420805273;9184.586693598803;9188.816223675489;9192.080791920755;9197.908020919705;9213.447193168297;5260.894782104413;5284.735763211901;5289.3652761668845;5299.417064122943;5303.416624171338;4169.145325208325;4411;4411.580899814512;4848.17581011229;4940.555350018516;3776.3580191367532;3802.3726085196186;3867.8839634811;3868.5551161616772;3882.5729169791302;1201.6515210589007;1208.86098098718;1216.4465168348381;1221.0597839663587;1229.5266322465916;886.499127992682;898.4699027573632;900.4552245891141;934.514052692596;959.6785076999283;5763.682997435181;5884.264466941632;5896.3219229788265;5980.73086711099;6073.939260607426;905.0496978172893;956.2159029595665;976.702105857706;981.47000619666;984.8867380251363;3663.578688450809;3811.714121440903;3837.4627552142724;3912.2762288976633;3935.2916475034767;10497;10903.546701991989;10957.671269861918;11022.559097636165;11055.447227638586;10222;10720.035196832323;10854.403007834644;10945.398003109745;10950.835737463944;8069.112397636255;8149.79625509367;8165.305948994402;8174.509529428372;8218.972628421447;5653.3781284057895;5759.942400576108;5771.653700777967;5826.592138550261;5997.910031349446;9796.922338542612;9921.25590580695;9960.302778805704;10096.899031009596;10128.493575321058;9961.601535938771;10130.44282564466;10186.08325250731;10230.28388012832;10295.794084118126;6771.458283337222;7012.649367531705;7021.789346319619;7027.543209691354;7035.824104397431;7255.4921155518605;7689.3848492121615;7723.7682869514;8249.340052795882;8267.379946503916;7151.928480715126;7235.023271858442;7261.128664560287;7298.370464608984;7379.262073792578;7050.541714788523;7058.823529411806;7102.609356485443;7135.357817796424;7169.713211471482;6771.966140169465;6847.315268473113;6898.793036208922;6907.447404207551;6913.792586222421;4720.858374248778;4841.975790121027;4859.781309840995;4866.440359358719;4879.658423910292;4751.762411879323;4768;4858.82994095205;4867.123917694849;4936.703797772145 10:15:02 INFO - PROCESS | 2038 | |4;prototype.html;321.07210162629997;323.345225917517;328.2581366112586;333.27678936707343;334.46652589120373;4947.381577302837;5433.870258603461;5834.149461355506;5892.558058145645;5925.259342582177;4938;5819.214406055181;5830.425785038048;5866.362855029877;5873.295204575446;3712.3132220539287;4203.44472545158;4354.390385346054;4385.188740083095;4532.229520981425;4372.868813935571;4462.776861156945;4464.732116073046;4465.441819772528;4479.3057076153245;4423.4249547558775;4432.756198409086;4439.622632076262;4449.57729015743;4476.507584165739;4096.7914465232825;4180.979095104535;4280.143971205771;4366.214081465335;4413.6910416270875;3751.3997760358484;3800.277947190025;3803.2013277211818;3811.656950874407;3811.7331786774657;5581.846256864858;5638.182463542763;5649.237352957381;5656.547476201894;5659.801906933238;4860.881997140642;5155.0978578748945;5162.664426812245;5184.170532714786;5212.244224587452;5697.743601537941;5733.312002559678;6088.4520393164385;6172.321044685081;6173.950428427178;3946.9013274668077;4114.423980642712;4303.612674859278;4321.891952701176;4349.304111342201;5931.584789064767;6501.609903405811;6514.250861150981;6542.004688569984;6593.604383736991;4339.869803905888;4359.106383191438;4369.169857727022;4381.780910954503;4387.517373088957;4189.916201675949;4424.823007079745;4447.288433850568;4449.822007119744;4461.620762235247;4302.505211900609;5170.3278573785165;5170.37955445349;5196.1034222508515;5200.141976573898;5920.2303700519515;6228.636536270364;6231.2522497300615;6241.78153764616;6269.7492100316385;1282.9294388808519;1351.2568087551808;1457.1548501869102;1498.4980031689288;1537.2160198298948;950;1012.6101450941293;1021.382063851374;1031.566741968375;1034.1158309645296;4819.445763737145;5589.189567512769;5679.148127780866;5850.5612079094235;5861.941380586225;6449.967750161313;6450.6774661266745;6483.286838447767;6483.897737384656;6507.9023814642815;5616.241807356037;5829.183914252008;5834.299884013945;5855.648661080349;5870.706464676749;2905.694902035298;3232.3131459383517;3373.5108409280515;3382.340443613521;3417.5044618530173;6508.251551071593;6573.769918052845;6721.294264102296;6753.763618273337;6768.932310676831;5872.26596675407;6501.804945851632;6626.906560417574;6627.834304142435;6676.332366763285;6321.589096708607;6404.263509696259;6656.966715166393;6666;6689.595185011105;6411.006294024433;6414.134091897534;6426.293107758236;6451.258105317761;6464.547481676237;5117.334746482933;6379.234491861006;6384.489240860813;6391.6804159792755;6410.1987251593555;6017.729202185825;6141.815745527641;6712.429443497357;6752.561083529555;6765.221999470124;4345.174416860787;4364.956350436582;4369.815092453773;4382.298832186835;4408.184485869996;5024.995000999887;5583.385827558884;6443.516736244706;6461.838454038687;6486.54594178403;5258.605604579749;5494.423085575957;6211.409916057967;6237.095621135;6263.3736626337;6170.482824789827;6194.938050619617;6201.410865967726;6231.189945307081;6267.903116954423;5854.560907931837;5874.412558744091;6037.516998640011;6079.209702738615;6177.289611694533;5298.15229563268;6210.503159747119;6260.154879091265;6303.747850085945;6346.524010699309;5159.793608255778;5387.299651045339;6172.814815555541;6185.6907154641185;6208.3791620839365 10:15:02 INFO - PROCESS | 2038 | |5;yui.html;678.1658559971236;750.8085438213254;757.2465396930052;768.5696010234273;787.6376866641343;14856.851431485682;15141;15331.770023449657;15519.84480155198;15530;14244.501442449491;14314;14316.856831431682;14333.354999025043;14345.497907573237;743.8586668532988;768.9269519395676;913.808100298938;935.4714586258742;939.1876027236425;888.2893685051965;926.4626516620377;927.0405130689737;928.6563971330584;931.1945167430158;991.410110983967;1001.1240164855751;1002.1031177096494;1002.3384566186319;1002.5238011944341;772.8377040821434;798.4051881348374;800.5076877720219;993.2897977945768;993.8608594796734;592.3010847200302;702.9753958611424;732.9743458978963;733.101950111115;733.4425836364348;14827.629309267246;14903.925480372529;14918;14954.177520236382;14955.626109347244;12314.75370492594;12487.438065287084;12662.81005784914;12763.808542871864;12861.935690321488;9921.75195620108;10023.2482563808;10033.698989030341;10353.482325883751;10547.208959328005;3503.544539209912;3539.5752509698746;3559.181388280684;3561.269939662363;3584.0502266899034;80588.59705701434;81474;82495;82905.58547207285;84736;9495.57269922855;9639.036096390446;9688.515574221261;9863.506824658738;9972.052654997764;21870.343889683336;21901.561968760536;21942.561148776935;21944.780552194592;21955.341339759834;7276.272372762787;7387.963060184665;7411.444141689287;7527.774166774896;7529.284717951786;4057.8985525361513;4078.1435898461655;4116.341385378325;4120.835166593362;4373.693841431133;3523.1016090896655;3643.908902277464;3646.124930016777;3652.36083685354;3653.9269214616093;516.6848222584221;564.9858503985356;622.4149299658307;635.9523035772336;671.9428848547831;599.6432122886876;604.4106995679177;609.7225762278152;610.9236345456818;621.6177051113533;6105.542084343692;7343.596102214323;7546.9622651887485;7620.809479762939;7845.529268243924;499.46557183812973;513.956313713331;525.4561528817655;568.9857753556112;583.8511179649247;3623.347797396494;3682.521272234646;3716.2381711749026;3741.1702714659723;3804.9239015220096;70043;72910.6354468235;73028.2697173032;73165.26834731584;73261.26738732652;67232.3276767226;67760;68142;68298.29254268683;70859;57567.40946657327;59590.70204648949;61520.69239653773;61718.82811718792;62888.68555657192;7903.288704016666;7943.4836735612;8034.196580341919;8071.556064416513;8143.6742530298125;33848.49227261544;38957.41563876601;39520;40098.79950600228;40176.7991160054;52343.69140771511;53084;53271.46728532665;53762.92474150573;54717;10339.121174700234;10492.213084018576;10494.055535001886;10655.147588193082;10792.838107428552;11685.474153662935;11703.824442633197;11714.414279286171;11732.706682332668;11902.226355286879;10773;10852.620158294421;10878.945605271923;11142.108631309313;11194;10284.485775711335;10500.529925810546;11015.724606884893;11937;12345.629631111082;10469.476526173814;10713.625023124154;10819.296745711503;10929.289596176222;11169.441527923735;9417.48203848795;9632.373895696757;9671.516424178904;9727.645889720157;9984.35101718386;9159.862602061108;9654.179394751243;9682.806343873224;9701.514924253901;9791.020897910152 10:15:02 INFO - PROCESS | 2038 | __end_tp_report 10:15:02 INFO - PROCESS | 2038 | __start_cc_report 10:15:02 INFO - PROCESS | 2038 | _x_x_mozilla_cycle_collect,1400 10:15:02 INFO - PROCESS | 2038 | __end_cc_report 10:15:02 INFO - PROCESS | 2038 | __startTimestamp1461172502359__endTimestamp 10:15:02 INFO - PROCESS | 2038 | 10:15:02 INFO - PROCESS | 2038 | ------- Summary: start ------- 10:15:02 INFO - PROCESS | 2038 | Number of tests: 6 10:15:02 INFO - PROCESS | 2038 | 10:15:02 INFO - PROCESS | 2038 | [#0] dojo.html Cycles:165 Average:5765.58 Median:6042.94 stddev:662.61 (11.0%) stddev-sans-first:626.09 10:15:02 INFO - PROCESS | 2038 | Values: 2926.5 3391.6 3402.7 3434.9 3452.6 5634.5 5644.2 5674.9 5675.5 5701.4 4655.7 5745.6 5796.7 5908.2 5935.5 5162.4 5189.8 5197.3 5239.2 5239.4 5255.8 5270.1 5307.3 5315.3 5390.9 5154.4 5182.2 5253.6 5277.8 5278.5 5215.1 5255.0 5284.9 5302.8 5304.4 4269.2 5158.2 5204.2 5228.3 5301.9 5738.1 5748.7 5754.2 5756.1 5756.2 6126.8 6176.7 6208.0 6225.0 6295.4 6246.8 6309.0 6309.5 6326.7 6334.9 5833.2 5847.6 5849.5 5853.3 5858.8 6226.9 6255.0 6282.9 6291.5 6318.7 6125.5 6141.2 6141.8 6144.3 6155.7 5869.9 5947.2 6062.2 6110.7 6264.0 6042.9 6131.5 6133.0 6189.3 6237.2 6266.3 6332.4 6334.4 6335.5 6346.2 4909.0 4915.8 4932.8 4933.8 4951.1 4326.0 4437.8 4481.0 4500.6 4513.4 5750.5 5817.9 5819.9 5852.4 5856.7 6274.3 6306.9 6319.5 6338.2 6346.6 5618.2 5706.0 5707.6 5721.6 5809.5 5336.1 5360.7 5361.9 5362.1 5363.5 6283.5 6291.1 6314.8 6324.5 6332.7 6239.7 6317.7 6318.4 6337.0 6354.6 6196.7 6250.5 6263.4 6330.3 6333.3 6236.8 6246.0 6261.6 6274.2 6275.2 6270.5 6303.4 6304.5 6321.5 6332.8 5974.4 6094.9 6112.5 6174.9 6175.5 6131.8 6193.5 6202.6 6204.0 6205.1 5954.5 6020.4 6053.6 6064.4 6066.5 5969.4 6070.8 6145.0 6195.2 6211.0 6033.1 6063.0 6074.8 6082.2 6142.7 10:15:02 INFO - PROCESS | 2038 | 10:15:02 INFO - PROCESS | 2038 | [#1] ext.html Cycles:180 Average:59108.69 Median:171179.65 stddev:122561.18 (71.6%) stddev-sans-first:122825.96 10:15:02 INFO - PROCESS | 2038 | Values: 485.4 495.8 532.8 582.6 607.0 29883.9 37304.4 38226.6 38421.0 38423.8 40502.0 40869.8 41118.6 41246.0 41381.4 8412.8 9340.7 9576.7 9577.8 9604.2 8517.2 8646.1 8652.2 8654.7 11273.3 11295.6 11401.1 11409.4 11423.7 11435.3 11274.2 11342.1 11361.0 11367.9 11375.0 8446.0 11193.8 11256.9 11551.5 11558.8 32770.0 35718.8 37411.3 38105.0 38153.6 3167.3 3263.8 3314.9 3423.0 3635.3 18583.0 22952.3 28072.6 28974.7 29045.0 2173.8 2708.3 2712.4 2717.1 2899.0 336289.0 336721.0 337509.1 338935.0 338936.3 45429.5 53586.4 53880.7 54457.7 54473.0 57063.4 60001.0 60157.1 60306.0 60547.8 16052.4 16511.3 16514.8 16521.1 16546.9 12813.0 12897.5 12898.0 12906.3 12936.4 11637.8 14398.8 15433.4 15841.7 15882.0 5551.7 6617.0 6632.5 6681.7 6707.9 835.3 900.5 990.7 1015.8 1080.3 24348.9 27157.1 28973.9 29596.9 29848.9 1097.3 1102.8 1118.5 1162.3 1283.8 15003.5 15206.5 15210.6 15397.5 15428.8 568465.2 583633.0 585157.0 586718.0 587127.0 58400.7 58730.7 58989.0 59082.7 59099.0 1328.2 1447.8 1485.9 1490.5 1493.1 26079.0 26703.2 28110.7 28564.6 28695.7 43237.7 56329.0 58332.0 58468.1 58481.7 420836.0 423601.0 426884.0 428823.9 429817.0 20590.7 22892.5 23563.1 25152.2 25583.0 41507.0 42130.8 42468.6 43142.6 43774.0 35322.8 36501.6 36880.8 37532.6 37954.9 36532.0 36558.5 36984.0 37235.8 37372.4 36002.2 36486.8 36584.6 37037.0 37672.8 31586.8 32176.0 32264.0 33225.8 34710.8 23466.6 23777.4 23944.6 24185.5 24286.5 10:15:02 INFO - PROCESS | 2038 | 10:15:02 INFO - PROCESS | 2038 | [#2] jquery.html Cycles:180 Average:34386.53 Median:25422.11 stddev:100659.49 (396.0%) stddev-sans-first:100909.50 10:15:02 INFO - PROCESS | 2038 | Values: 390.3 393.8 396.3 398.2 406.3 19725.6 19946.7 20473.7 20543.5 21254.0 20165.5 20532.2 21611.4 21637.8 21697.0 4890.3 6128.6 6136.9 6143.6 6153.3 5216.7 5584.8 5954.2 6009.6 6019.7 5956.1 5961.9 5966.0 5966.6 5967.0 5710.5 6121.4 6142.7 6150.5 6155.4 5664.8 5892.4 5935.6 5949.3 5962.0 13671.4 13722.9 18537.2 24807.0 26037.2 2315.8 2322.8 2398.0 2399.6 2767.6 9263.7 9875.4 10035.5 10062.6 10142.5 1750.5 1775.3 1792.9 1801.2 1817.9 113158.0 117045.4 117638.0 118867.0 122536.0 11492.4 11552.3 11618.2 11681.0 11771.4 15003.9 15099.3 15111.3 15115.0 15117.0 8399.8 8593.1 8602.7 8712.7 8744.3 6830.5 8389.3 8407.4 8559.2 8606.0 4470.6 4564.4 4576.3 4617.9 4622.7 1600.5 1883.8 1900.1 1913.1 1924.2 864.6 879.6 915.1 984.3 1049.5 20034.7 20668.5 20733.6 20847.3 20869.0 966.3 974.8 1005.3 1005.7 1023.6 10409.4 10832.3 10849.3 10852.0 10888.0 592834.0 595628.0 599981.0 616249.0 617696.0 84196.6 120497.0 127915.7 131914.0 132388.0 983.7 991.0 1012.6 1012.8 1016.6 17614.6 17890.4 18025.8 18053.4 18195.0 47051.0 47903.0 48313.5 48368.3 48502.0 72706.6 72808.3 73241.6 73290.0 75707.9 7607.4 7668.2 7779.5 7823.3 8157.8 10638.0 11766.3 11972.3 12060.0 12151.6 10018.6 10223.3 10520.9 10554.7 10640.8 8478.6 10002.9 10074.6 10247.1 10307.5 9364.3 9681.5 10220.8 10431.2 10794.9 7677.3 7714.8 7753.6 7820.4 8069.6 8821.8 9618.8 9827.8 10537.0 10573.9 10:15:02 INFO - PROCESS | 2038 | 10:15:02 INFO - PROCESS | 2038 | [#3] mootools.html Cycles:180 Average:5645.49 Median:4863.11 stddev:3150.45 (64.8%) stddev-sans-first:3143.28 10:15:02 INFO - PROCESS | 2038 | Values: 1419.7 1477.0 1555.7 1826.5 1983.3 7927.7 8621.0 8860.5 8873.2 8889.9 7550.6 8728.3 8735.4 8752.1 8756.9 2042.7 2442.8 2469.2 2471.4 2476.4 2427.5 2449.7 2465.8 2471.9 2475.6 2435.4 2449.4 2453.2 2461.8 2463.9 2393.9 2424.0 2424.8 2435.0 2446.7 2399.5 2426.2 2428.8 2432.5 2435.1 8518.2 8633.8 8664.3 8700.0 8701.2 5246.6 5473.6 5507.1 5523.3 5523.7 3449.6 3549.8 3646.7 3669.2 3677.6 1022.3 1048.5 1053.1 1058.8 1060.1 11678.3 11681.1 11704.0 11709.9 11785.2 4525.2 4600.6 4750.5 4756.9 4781.4 9184.6 9188.8 9192.1 9197.9 9213.4 5260.9 5284.7 5289.4 5299.4 5303.4 4169.1 4411.0 4411.6 4848.2 4940.6 3776.4 3802.4 3867.9 3868.6 3882.6 1201.7 1208.9 1216.4 1221.1 1229.5 886.5 898.5 900.5 934.5 959.7 5763.7 5884.3 5896.3 5980.7 6073.9 905.0 956.2 976.7 981.5 984.9 3663.6 3811.7 3837.5 3912.3 3935.3 10497.0 10903.5 10957.7 11022.6 11055.4 10222.0 10720.0 10854.4 10945.4 10950.8 8069.1 8149.8 8165.3 8174.5 8219.0 5653.4 5759.9 5771.7 5826.6 5997.9 9796.9 9921.3 9960.3 10096.9 10128.5 9961.6 10130.4 10186.1 10230.3 10295.8 6771.5 7012.6 7021.8 7027.5 7035.8 7255.5 7689.4 7723.8 8249.3 8267.4 7151.9 7235.0 7261.1 7298.4 7379.3 7050.5 7058.8 7102.6 7135.4 7169.7 6772.0 6847.3 6898.8 6907.4 6913.8 4720.9 4842.0 4859.8 4866.4 4879.7 4751.8 4768.0 4858.8 4867.1 4936.7 10:15:02 INFO - PROCESS | 2038 | 10:15:02 INFO - PROCESS | 2038 | [#4] prototype.html Cycles:180 Average:5076.09 Median:5652.89 stddev:1570.07 (27.8%) stddev-sans-first:1533.37 10:15:02 INFO - PROCESS | 2038 | Values: 321.1 323.3 328.3 333.3 334.5 4947.4 5433.9 5834.1 5892.6 5925.3 4938.0 5819.2 5830.4 5866.4 5873.3 3712.3 4203.4 4354.4 4385.2 4532.2 4372.9 4462.8 4464.7 4465.4 4479.3 4423.4 4432.8 4439.6 4449.6 4476.5 4096.8 4181.0 4280.1 4366.2 4413.7 3751.4 3800.3 3803.2 3811.7 3811.7 5581.8 5638.2 5649.2 5656.5 5659.8 4860.9 5155.1 5162.7 5184.2 5212.2 5697.7 5733.3 6088.5 6172.3 6174.0 3946.9 4114.4 4303.6 4321.9 4349.3 5931.6 6501.6 6514.3 6542.0 6593.6 4339.9 4359.1 4369.2 4381.8 4387.5 4189.9 4424.8 4447.3 4449.8 4461.6 4302.5 5170.3 5170.4 5196.1 5200.1 5920.2 6228.6 6231.3 6241.8 6269.7 1282.9 1351.3 1457.2 1498.5 1537.2 950.0 1012.6 1021.4 1031.6 1034.1 4819.4 5589.2 5679.1 5850.6 5861.9 6450.0 6450.7 6483.3 6483.9 6507.9 5616.2 5829.2 5834.3 5855.6 5870.7 2905.7 3232.3 3373.5 3382.3 3417.5 6508.3 6573.8 6721.3 6753.8 6768.9 5872.3 6501.8 6626.9 6627.8 6676.3 6321.6 6404.3 6657.0 6666.0 6689.6 6411.0 6414.1 6426.3 6451.3 6464.5 5117.3 6379.2 6384.5 6391.7 6410.2 6017.7 6141.8 6712.4 6752.6 6765.2 4345.2 4365.0 4369.8 4382.3 4408.2 5025.0 5583.4 6443.5 6461.8 6486.5 5258.6 5494.4 6211.4 6237.1 6263.4 6170.5 6194.9 6201.4 6231.2 6267.9 5854.6 5874.4 6037.5 6079.2 6177.3 5298.2 6210.5 6260.2 6303.7 6346.5 5159.8 5387.3 6172.8 6185.7 6208.4 10:15:02 INFO - PROCESS | 2038 | 10:15:02 INFO - PROCESS | 2038 | [#5] yui.html Cycles:180 Average:16504.36 Median:54239.96 stddev:22107.56 (40.8%) stddev-sans-first:22137.64 10:15:02 INFO - PROCESS | 2038 | Values: 678.2 750.8 757.2 768.6 787.6 14856.9 15141.0 15331.8 15519.8 15530.0 14244.5 14314.0 14316.9 14333.4 14345.5 743.9 768.9 913.8 935.5 939.2 888.3 926.5 927.0 928.7 931.2 991.4 1001.1 1002.1 1002.3 1002.5 772.8 798.4 800.5 993.3 993.9 592.3 703.0 733.0 733.1 733.4 14827.6 14903.9 14918.0 14954.2 14955.6 12314.8 12487.4 12662.8 12763.8 12861.9 9921.8 10023.2 10033.7 10353.5 10547.2 3503.5 3539.6 3559.2 3561.3 3584.1 80588.6 81474.0 82495.0 82905.6 84736.0 9495.6 9639.0 9688.5 9863.5 9972.1 21870.3 21901.6 21942.6 21944.8 21955.3 7276.3 7388.0 7411.4 7527.8 7529.3 4057.9 4078.1 4116.3 4120.8 4373.7 3523.1 3643.9 3646.1 3652.4 3653.9 516.7 565.0 622.4 636.0 671.9 599.6 604.4 609.7 610.9 621.6 6105.5 7343.6 7547.0 7620.8 7845.5 499.5 514.0 525.5 569.0 583.9 3623.3 3682.5 3716.2 3741.2 3804.9 70043.0 72910.6 73028.3 73165.3 73261.3 67232.3 67760.0 68142.0 68298.3 70859.0 57567.4 59590.7 61520.7 61718.8 62888.7 7903.3 7943.5 8034.2 8071.6 8143.7 33848.5 38957.4 39520.0 40098.8 40176.8 52343.7 53084.0 53271.5 53762.9 54717.0 10339.1 10492.2 10494.1 10655.1 10792.8 11685.5 11703.8 11714.4 11732.7 11902.2 10773.0 10852.6 10878.9 11142.1 11194.0 10284.5 10500.5 11015.7 11937.0 12345.6 10469.5 10713.6 10819.3 10929.3 11169.4 9417.5 9632.4 9671.5 9727.6 9984.4 9159.9 9654.2 9682.8 9701.5 9791.0 10:15:02 INFO - PROCESS | 2038 | -------- Summary: end -------- 10:15:02 INFO - PROCESS | 2038 | 10:15:02 INFO - TEST-INFO | 2038: exit 0 10:15:02 INFO - TEST-OK | dromaeo_css | took 1115451ms 10:15:02 INFO - TEST-START | kraken 10:15:02 INFO - operating with platform_type : mac_ 10:15:02 INFO - Initialising browser for kraken test... 10:15:02 INFO - TEST-INFO | started process 2042 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpPUz7_6/profile http://localhost:51403/getInfo.html) 10:15:05 INFO - PROCESS | 2042 | __metrics Screen width/height:1600/1200 10:15:05 INFO - PROCESS | 2042 | colorDepth:24 10:15:05 INFO - PROCESS | 2042 | Browser inner width/height: 1024/689 10:15:05 INFO - PROCESS | 2042 | __metrics 10:15:05 INFO - PROCESS | 2042 | 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" 10:15:05 ERROR - PROCESS | 2042 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:15:06 INFO - TEST-INFO | 2042: exit 0 10:15:06 INFO - Browser initialized. 10:15:06 INFO - Running cycle 1/1 for kraken test... 10:15:06 INFO - TEST-INFO | started process 2044 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpPUz7_6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:17 INFO - PROCESS | 2044 | RSS: Main: 237875200 10:15:17 INFO - PROCESS | 2044 | 10:15:20 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:51403/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51403/tests/kraken/driver.html?testName=audio-beat-detection) 10:15:21 INFO - PROCESS | 2044 | RSS: Main: 286277632 10:15:21 INFO - PROCESS | 2044 | 10:15:24 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:51403/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51403/tests/kraken/driver.html?testName=audio-dft) 10:15:24 INFO - PROCESS | 2044 | RSS: Main: 299470848 10:15:24 INFO - PROCESS | 2044 | 10:15:28 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:51403/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51403/tests/kraken/driver.html?testName=audio-fft) 10:15:29 INFO - PROCESS | 2044 | RSS: Main: 387809280 10:15:29 INFO - PROCESS | 2044 | 10:15:31 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:51403/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51403/tests/kraken/driver.html?testName=audio-oscillator) 10:15:31 INFO - PROCESS | 2044 | RSS: Main: 286248960 10:15:31 INFO - PROCESS | 2044 | 10:15:33 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:51403/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51403/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:15:34 INFO - PROCESS | 2044 | RSS: Main: 290508800 10:15:34 INFO - PROCESS | 2044 | 10:15:37 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:51403/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51403/tests/kraken/driver.html?testName=imaging-darkroom) 10:15:37 INFO - PROCESS | 2044 | RSS: Main: 330194944 10:15:37 INFO - PROCESS | 2044 | 10:15:40 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:51403/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51403/tests/kraken/driver.html?testName=imaging-desaturate) 10:15:41 INFO - PROCESS | 2044 | RSS: Main: 330858496 10:15:41 INFO - PROCESS | 2044 | 10:15:44 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:51403/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51403/tests/kraken/driver.html?testName=json-parse-financial) 10:15:44 INFO - PROCESS | 2044 | RSS: Main: 327471104 10:15:44 INFO - PROCESS | 2044 | 10:15:46 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:51403/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51403/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:15:46 INFO - PROCESS | 2044 | RSS: Main: 319938560 10:15:46 INFO - PROCESS | 2044 | 10:15:48 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:51403/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51403/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:15:49 INFO - PROCESS | 2044 | RSS: Main: 326668288 10:15:49 INFO - PROCESS | 2044 | 10:15:51 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:51403/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51403/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:15:52 INFO - PROCESS | 2044 | RSS: Main: 330498048 10:15:52 INFO - PROCESS | 2044 | 10:15:55 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:51403/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:15:55 INFO - PROCESS | 2044 | RSS: Main: 330870784 10:15:55 INFO - PROCESS | 2044 | 10:15:58 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:51403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:15:59 INFO - PROCESS | 2044 | RSS: Main: 328523776 10:15:59 INFO - PROCESS | 2044 | 10:16:00 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:51403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51403/tests/kraken/driver.html?testName=ai-astar) 10:16:01 INFO - PROCESS | 2044 | RSS: Main: 393580544 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | __start_tp_report 10:16:01 INFO - PROCESS | 2044 | _x_x_mozilla_page_load 10:16:01 INFO - PROCESS | 2044 | _x_x_mozilla_page_load_details 10:16:01 INFO - PROCESS | 2044 | |i|pagename|runs| 10:16:01 INFO - PROCESS | 2044 | |0;ai-astar;113;112;111;110;113;114;119;112;115;121 10:16:01 INFO - PROCESS | 2044 | |1;audio-beat-detection;164;148;180;165;117;139;121;155;155;118 10:16:01 INFO - PROCESS | 2044 | |2;audio-dft;253;251;184;186;183;186;184;181;185;184 10:16:01 INFO - PROCESS | 2044 | |3;audio-fft;72;75;87;88;56;57;60;79;83;54 10:16:01 INFO - PROCESS | 2044 | |4;audio-oscillator;89;96;135;78;78;79;122;80;77;127 10:16:01 INFO - PROCESS | 2044 | |5;imaging-gaussian-blur;92;130;122;87;90;85;90;87;92;85 10:16:01 INFO - PROCESS | 2044 | |6;imaging-darkroom;95;95;95;95;94;94;95;94;95;94 10:16:01 INFO - PROCESS | 2044 | |7;imaging-desaturate;84;84;85;84;84;83;86;84;84;85 10:16:01 INFO - PROCESS | 2044 | |8;json-parse-financial;60;59;58;57;57;56;57;76;59;55 10:16:01 INFO - PROCESS | 2044 | |9;json-stringify-tinderbox;61;60;79;73;69;66;68;94;95;100 10:16:01 INFO - PROCESS | 2044 | |10;stanford-crypto-aes;82;82;81;80;82;80;81;78;83;81 10:16:01 INFO - PROCESS | 2044 | |11;stanford-crypto-ccm;144;140;139;137;150;121;157;152;191;167 10:16:01 INFO - PROCESS | 2044 | |12;stanford-crypto-pbkdf2;171;168;168;165;168;168;167;167;158;168 10:16:01 INFO - PROCESS | 2044 | |13;stanford-crypto-sha256-iterative;67;67;69;71;70;69;67;68;71;67 10:16:01 INFO - PROCESS | 2044 | __end_tp_report 10:16:01 INFO - PROCESS | 2044 | __start_cc_report 10:16:01 INFO - PROCESS | 2044 | _x_x_mozilla_cycle_collect,1933 10:16:01 INFO - PROCESS | 2044 | __end_cc_report 10:16:01 INFO - PROCESS | 2044 | __startTimestamp1461172561155__endTimestamp 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | ------- Summary: start ------- 10:16:01 INFO - PROCESS | 2044 | Number of tests: 14 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | [#0] ai-astar Cycles:10 Average:114.00 Median:113.50 stddev:3.50 (3.1%) stddev-sans-first:3.69 10:16:01 INFO - PROCESS | 2044 | Values: 113.0 112.0 111.0 110.0 113.0 114.0 119.0 112.0 115.0 121.0 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:155.00 stddev:21.87 (14.1%) stddev-sans-first:22.23 10:16:01 INFO - PROCESS | 2044 | Values: 164.0 148.0 180.0 165.0 117.0 139.0 121.0 155.0 155.0 118.0 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | [#2] audio-dft Cycles:10 Average:197.70 Median:185.50 stddev:28.66 (15.4%) stddev-sans-first:22.34 10:16:01 INFO - PROCESS | 2044 | Values: 253.0 251.0 184.0 186.0 183.0 186.0 184.0 181.0 185.0 184.0 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | [#3] audio-fft Cycles:10 Average:71.10 Median:77.00 stddev:13.34 (17.3%) stddev-sans-first:14.14 10:16:01 INFO - PROCESS | 2044 | Values: 72.0 75.0 87.0 88.0 56.0 57.0 60.0 79.0 83.0 54.0 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:78.50 stddev:23.00 (29.3%) stddev-sans-first:24.25 10:16:01 INFO - PROCESS | 2044 | Values: 89.0 96.0 135.0 78.0 78.0 79.0 122.0 80.0 77.0 127.0 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | [#5] imaging-gaussian-blur Cycles:10 Average:96.00 Median:88.50 stddev:16.12 (18.2%) stddev-sans-first:17.04 10:16:01 INFO - PROCESS | 2044 | Values: 92.0 130.0 122.0 87.0 90.0 85.0 90.0 87.0 92.0 85.0 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:16:01 INFO - PROCESS | 2044 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 94.0 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 10:16:01 INFO - PROCESS | 2044 | Values: 84.0 84.0 85.0 84.0 84.0 83.0 86.0 84.0 84.0 85.0 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:58.50 stddev:6.02 (10.3%) stddev-sans-first:6.38 10:16:01 INFO - PROCESS | 2044 | Values: 60.0 59.0 58.0 57.0 57.0 56.0 57.0 76.0 59.0 55.0 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | [#9] json-stringify-tinderbox Cycles:10 Average:76.50 Median:71.00 stddev:14.80 (20.8%) stddev-sans-first:14.59 10:16:01 INFO - PROCESS | 2044 | Values: 61.0 60.0 79.0 73.0 69.0 66.0 68.0 94.0 95.0 100.0 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.50 stddev:1.41 (1.7%) stddev-sans-first:1.45 10:16:01 INFO - PROCESS | 2044 | Values: 82.0 82.0 81.0 80.0 82.0 80.0 81.0 78.0 83.0 81.0 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:151.00 stddev:19.12 (12.7%) stddev-sans-first:20.16 10:16:01 INFO - PROCESS | 2044 | Values: 144.0 140.0 139.0 137.0 150.0 121.0 157.0 152.0 191.0 167.0 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:168.00 stddev:3.43 (2.0%) stddev-sans-first:3.28 10:16:01 INFO - PROCESS | 2044 | Values: 171.0 168.0 168.0 165.0 168.0 168.0 167.0 167.0 158.0 168.0 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - PROCESS | 2044 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.65 (2.4%) stddev-sans-first:1.64 10:16:01 INFO - PROCESS | 2044 | Values: 67.0 67.0 69.0 71.0 70.0 69.0 67.0 68.0 71.0 67.0 10:16:01 INFO - PROCESS | 2044 | -------- Summary: end -------- 10:16:01 INFO - PROCESS | 2044 | 10:16:01 INFO - TEST-INFO | 2044: exit 0 10:16:01 INFO - TEST-OK | kraken | took 59000ms 10:16:01 INFO - SUITE-END | took 1174s 10:16:02 INFO - Completed test suite (00:19:34) 10:16:02 INFO - javascript benchmark 10:16:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2926.4878646236903, 3391.6269210386854, 3402.693757561819, 3434.8969530914064, 3452.5684289463816, 5634.549236061105, 5644.238027866237, 5674.858128546788, 5675.489205971462, 5701.401352857953, 4655.697379670319, 5745.6265342752695, 5796.710164491779, 5908.202392676987, 5935.465808077272, 5162.432132465426, 5189.8183563575285, 5197.272381866542, 5239.21411788231, 5239.397469291042, 5255.763490642911, 5270.104082305998, 5307.2569840222395, 5315.309009828717, 5390.9191362129595, 5154.433012368637, 5182.222666600041, 5253.553447956928, 5277.788888444457, 5278.4721527846905, 5215.113430716788, 5254.97372513135, 5284.894302113936, 5302.840914772563, 5304.416514183436, 4269.231538323101, 5158.226266060084, 5204.219367094966, 5228.320318358589, 5301.867453313659, 5738.081906894877, 5748.65508069513, 5754.165645981309, 5756.107803290455, 5756.165356023395, 6126.785562505291, 6176.69116544171, 6208.00671892495, 6225.0, 6295.370462953714, 6246.750129994794, 6309.022101574264, 6309.495240380758, 6326.683665816737, 6334.936650633527, 5833.2416785817995, 5847.619904706181, 5849.532037436995, 5853.326867410217, 5858.8242352729485, 6226.875462490725, 6255.0, 6282.905756413657, 6291.465225455888, 6318.652474113968, 6125.540694081788, 6141.170941922873, 6141.84645383869, 6144.324124346318, 6155.661438620829, 5869.914065897822, 5947.226860508106, 6062.181605483203, 6110.694465276719, 6263.96868015657, 6042.939570604238, 6131.540134489931, 6132.967444181115, 6189.257289125334, 6237.220347456568, 6266.279377871512, 6332.366763323631, 6334.3665633436285, 6335.493160547145, 6346.238451385863, 4908.950910490849, 4915.803367865316, 4932.7533623319405, 4933.777979990838, 4951.10880041596, 4326.0, 4437.755923424178, 4481.014176881081, 4500.639948804153, 4513.435820522434, 5750.482456578928, 5817.854553636108, 5819.94180058194, 5852.356240813507, 5856.677882716492, 6274.2784579773, 6306.905396419057, 6319.526035547352, 6338.207724034496, 6346.555741098171, 5618.213450116987, 5706.0, 5707.571932105026, 5721.5708821838525, 5809.5352371811, 5336.146216605324, 5360.70516121617, 5361.919571206435, 5362.1420572708175, 5363.5440987516495, 6283.528735344776, 6291.087792270096, 6314.810555683337, 6324.462420694109, 6332.746690132435, 6239.688015599293, 6317.684115794284, 6318.399752023551, 6336.968315158395, 6354.586951848115, 6196.659183744938, 6250.4687101595055, 6263.4362907338555, 6330.272018717907, 6333.334999824952, 6236.844078898064, 6246.0, 6261.56169068179, 6274.1843560336865, 6275.152854364785, 6270.4670103039925, 6303.432691057827, 6304.495640348853, 6321.52588555851, 6332.778352757631, 5974.40255974399, 6094.908576371269, 6112.510999119971, 6174.907376389448, 6175.536834737502, 6131.774283661862, 6193.535484838745, 6202.627842329474, 6204.038374052029, 6205.069239614094, 5954.46409823118, 6020.367861374668, 6053.576249662481, 6064.363241859542, 6066.484348830399, 5969.403059693996, 6070.848228794315, 6145.0, 6195.2255968004, 6211.0372892201785, 6033.12519684652, 6063.0, 6074.757009719562, 6082.178905847654, 6142.723577438936], "value": 5721.751141991467, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.3520550065662, 495.84876612633155, 532.8241680245518, 582.6154737873005, 607.019663243861, 29883.85058074712, 37304.44043339349, 38226.61773382262, 38421.0, 38423.80788096062, 40501.987450313754, 40869.79565102178, 41118.58881411185, 41246.0, 41381.37927931076, 8412.789680258013, 9340.673076442308, 9576.664816731416, 9577.76055598612, 9604.2316614671, 8517.190866867637, 8646.135386461367, 8652.178043085929, 8654.740357789276, 11273.267237629569, 11295.604653837117, 11401.144914131432, 11409.42952852354, 11423.657290281264, 11435.256708313975, 11274.210805243636, 11342.149338799623, 11361.0, 11367.943160284229, 11374.999999999958, 8446.0, 11193.776124477465, 11256.887431125666, 11551.53793848245, 11558.826617600742, 32770.0, 35718.821405892806, 37411.25177496462, 38105.0473738156, 38153.618463815284, 3167.33485967947, 3263.7552183586326, 3314.93370132596, 3423.0, 3635.327464419091, 18582.9779362135, 22952.311430657108, 28072.57891131635, 28974.710252897414, 29045.0, 2173.7717539658424, 2708.3499960009653, 2712.443948990452, 2717.062613398374, 2899.043315705812, 336289.0, 336721.0, 337509.12454377185, 338935.0, 338936.3053184743, 45429.54570454253, 53586.39240822782, 53880.6895448371, 54457.72771136119, 54473.0, 57063.429365706645, 60001.0, 60157.09764353538, 60306.0, 60547.78904421975, 16052.357905683875, 16511.33954641825, 16514.83485165133, 16521.091339976178, 16546.91726541384, 12812.974962003018, 12897.484100636057, 12897.968162546973, 12906.29015404143, 12936.353182340845, 11637.767244655059, 14398.784018239734, 15433.38266469351, 15841.68316633684, 15882.047077175406, 5551.667599776106, 6616.96691516549, 6632.535722499379, 6681.665916704243, 6707.865842683119, 835.3275613131487, 900.4822227219244, 990.7473594233569, 1015.7765291635828, 1080.3140006096185, 24348.904299306574, 27157.10996601217, 28973.855130724212, 29596.852015739783, 29848.850755746083, 1097.2703152403562, 1102.8125218712837, 1118.4519585403257, 1162.3200427749691, 1283.768921594122, 15003.474878379422, 15206.467773628092, 15210.619734506505, 15397.461088861835, 15428.768568471482, 568465.157674209, 583633.0, 585157.0, 586718.0, 587127.0, 58400.70799645974, 58730.706346467996, 58989.0, 59082.70458647679, 59099.0, 1328.2030781531005, 1447.7538818401108, 1485.9108453492825, 1490.5169356490362, 1493.0966765106955, 26079.0, 26703.19890403291, 28110.718892811627, 28564.57153142746, 28695.713042869305, 43237.702868913984, 56329.0, 58332.0, 58468.122978156214, 58481.70759146177, 420836.0, 423601.0, 426884.0, 428823.8558807311, 429817.0, 20590.691139632618, 22892.542149157256, 23563.0574777007, 25152.24543263705, 25582.976680932556, 41507.0, 42130.847278298315, 42468.57531424646, 43142.64177890584, 43774.0, 35322.823385882904, 36501.63498365089, 36880.81559592185, 37532.624673752915, 37954.86135415942, 36532.0, 36558.45162322514, 36984.0, 37235.81382093072, 37372.43941340937, 36002.21092415596, 36486.817565912, 36584.634153658124, 37037.0, 37672.811635941645, 31586.842065789522, 32176.0, 32264.032079037668, 33225.833870830495, 34710.82644586862, 23466.64800028035, 23777.405564861016, 23944.64083038721, 24185.51628967446, 24286.51426971486], "value": 18961.15293328411, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.3072047116368, 393.77948348924593, 396.2510854485024, 398.2373754260591, 406.3153586207241, 19725.60548789025, 19946.70079948802, 20473.692894606593, 20543.486412839688, 21254.0, 20165.495862603442, 20532.17871285147, 21611.351659450203, 21637.783622163774, 21697.0, 4890.339804126433, 6128.6322820630685, 6136.9079463808075, 6143.600665956698, 6153.292371377282, 5216.660917040399, 5584.832455026356, 5954.166416701665, 6009.639421634694, 6019.729112189962, 5956.076808094752, 5961.850953726148, 5966.0, 5966.582339236255, 5966.985612445873, 5710.486056254937, 6121.357257487966, 6142.662153581551, 6150.538709596798, 6155.446009859112, 5664.801731939362, 5892.438503796455, 5935.575461889159, 5949.315828679714, 5961.986462301419, 13671.38478768448, 13722.931385343009, 18537.165827537792, 24807.00771969119, 26037.21888343353, 2315.8263130265127, 2322.8257880659016, 2398.0, 2399.616061430163, 2767.5986981887513, 9263.722088337361, 9875.358101723437, 10035.548400322003, 10062.64780732678, 10142.492875356204, 1750.5011071844463, 1775.254393154878, 1792.9103544822706, 1801.189464740872, 1817.9363722269788, 113158.0, 117045.41477292644, 117638.0, 118867.0, 122536.0, 11492.42537873103, 11552.306861588331, 11618.244814087057, 11681.0, 11771.352575608424, 15003.924980375028, 15099.320530576151, 15111.31999060045, 15115.0, 15117.017393869362, 8399.758122148276, 8593.097724738938, 8602.741917742478, 8712.69505567302, 8744.300455963508, 6830.453563714891, 8389.286910612544, 8407.369447291478, 8559.229669329665, 8606.0, 4470.5976462117915, 4564.406627138451, 4576.336431217454, 4617.930731039037, 4622.699524530894, 1600.5438450041681, 1883.7645294338208, 1900.1354383755358, 1913.0817207740363, 1924.162989099746, 864.6368525219423, 879.5865943006777, 915.1031988651159, 984.2863923655435, 1049.490996866519, 20034.69947950782, 20668.483287917923, 20733.58532829335, 20847.304777611072, 20869.0, 966.3380584299778, 974.8147851908257, 1005.2661557063385, 1005.6832097889142, 1023.6212601337553, 10409.42748148844, 10832.29566170254, 10849.349039057524, 10852.023317901427, 10887.965643263877, 592834.0, 595628.0, 599981.0, 616249.0, 617696.0, 84196.57901710452, 120497.0, 127915.72084279225, 131914.0, 132388.0, 983.6508039645822, 990.9801803964025, 1012.6202673997251, 1012.8278192707257, 1016.5577973581368, 17614.647707046042, 17890.373836916166, 18025.819741802414, 18053.368132115313, 18195.00971520295, 47051.0, 47902.97018813114, 48313.549832026874, 48368.27447588359, 48502.0, 72706.63646681733, 72808.27191728014, 73241.63379183284, 73290.0, 75707.8643820332, 7607.353374962969, 7668.194839541768, 7779.4554381192775, 7823.295903368724, 8157.8368432632205, 10638.0, 11766.294022358687, 11972.281663100242, 12060.0, 12151.635450936486, 10018.599256029676, 10223.284370094021, 10520.894791051991, 10554.683359499228, 10640.84038739435, 8478.618462169094, 10002.949985250027, 10074.597016119273, 10247.128994035591, 10307.536160872629, 9364.250859931326, 9681.467519286225, 10220.846687299547, 10431.165506759593, 10794.892051079389, 7677.347425468898, 7714.845703086019, 7753.612319384121, 7820.3743700504965, 8069.636866341146, 8821.779455513664, 9618.807623847624, 9827.754306142404, 10536.998985096403, 10573.947130264607], "value": 9346.017626875902, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.687668712884, 1477.0177831741892, 1555.6655319106394, 1826.5251034730966, 1983.305842954967, 7927.682892684285, 8621.0, 8860.512671803048, 8873.245774109193, 8889.866652000224, 7550.5847178405165, 8728.301735861132, 8735.388522803407, 8752.081031491698, 8756.91243087569, 2042.7242322286525, 2442.8412153210074, 2469.1975108089855, 2471.4439251168433, 2476.3809047738064, 2427.4659574893494, 2449.6815413996155, 2465.7657522535333, 2471.9011239550396, 2475.591527397977, 2435.4398488347692, 2449.448874003344, 2453.1659235859806, 2461.7538246175327, 2463.864487453189, 2393.892274847636, 2423.987880060597, 2424.842385244953, 2435.0259896041634, 2446.694163229596, 2399.5200959808108, 2426.2236084452984, 2428.793552548018, 2432.4891772727747, 2435.099013365066, 8518.233358997659, 8633.827323453495, 8664.306855451548, 8699.99950005751, 8701.17338852808, 5246.554042906358, 5473.562115030788, 5507.118860982224, 5523.337199536081, 5523.696196709179, 3449.5688038995127, 3549.7515173937836, 3646.708263338953, 3669.2294618130227, 3677.595464498903, 1022.2639699416409, 1048.5386429970788, 1053.1311667873958, 1058.830587106067, 1060.093619954935, 11678.299302041905, 11681.065514758799, 11704.005159561448, 11709.94145029278, 11785.233959792586, 4525.230710779176, 4600.631949444037, 4750.548697873696, 4756.904861902743, 4781.378420805273, 9184.586693598803, 9188.816223675489, 9192.080791920755, 9197.908020919705, 9213.447193168297, 5260.894782104413, 5284.735763211901, 5289.3652761668845, 5299.417064122943, 5303.416624171338, 4169.145325208325, 4411.0, 4411.580899814512, 4848.17581011229, 4940.555350018516, 3776.3580191367532, 3802.3726085196186, 3867.8839634811, 3868.5551161616772, 3882.5729169791302, 1201.6515210589007, 1208.86098098718, 1216.4465168348381, 1221.0597839663587, 1229.5266322465916, 886.499127992682, 898.4699027573632, 900.4552245891141, 934.514052692596, 959.6785076999283, 5763.682997435181, 5884.264466941632, 5896.3219229788265, 5980.73086711099, 6073.939260607426, 905.0496978172893, 956.2159029595665, 976.702105857706, 981.47000619666, 984.8867380251363, 3663.578688450809, 3811.714121440903, 3837.4627552142724, 3912.2762288976633, 3935.2916475034767, 10497.0, 10903.546701991989, 10957.671269861918, 11022.559097636165, 11055.447227638586, 10222.0, 10720.035196832323, 10854.403007834644, 10945.398003109745, 10950.835737463944, 8069.112397636255, 8149.79625509367, 8165.305948994402, 8174.509529428372, 8218.972628421447, 5653.3781284057895, 5759.942400576108, 5771.653700777967, 5826.592138550261, 5997.910031349446, 9796.922338542612, 9921.25590580695, 9960.302778805704, 10096.899031009596, 10128.493575321058, 9961.601535938771, 10130.44282564466, 10186.08325250731, 10230.28388012832, 10295.794084118126, 6771.458283337222, 7012.649367531705, 7021.789346319619, 7027.543209691354, 7035.824104397431, 7255.4921155518605, 7689.3848492121615, 7723.7682869514, 8249.340052795882, 8267.379946503916, 7151.928480715126, 7235.023271858442, 7261.128664560287, 7298.370464608984, 7379.262073792578, 7050.541714788523, 7058.823529411806, 7102.609356485443, 7135.357817796424, 7169.713211471482, 6771.966140169465, 6847.315268473113, 6898.793036208922, 6907.447404207551, 6913.792586222421, 4720.858374248778, 4841.975790121027, 4859.781309840995, 4866.440359358719, 4879.658423910292, 4751.762411879323, 4768.0, 4858.82994095205, 4867.123917694849, 4936.703797772145], "value": 4559.334346745926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.07210162629997, 323.345225917517, 328.2581366112586, 333.27678936707343, 334.46652589120373, 4947.381577302837, 5433.870258603461, 5834.149461355506, 5892.558058145645, 5925.259342582177, 4938.0, 5819.214406055181, 5830.425785038048, 5866.362855029877, 5873.295204575446, 3712.3132220539287, 4203.44472545158, 4354.390385346054, 4385.188740083095, 4532.229520981425, 4372.868813935571, 4462.776861156945, 4464.732116073046, 4465.441819772528, 4479.3057076153245, 4423.4249547558775, 4432.756198409086, 4439.622632076262, 4449.57729015743, 4476.507584165739, 4096.7914465232825, 4180.979095104535, 4280.143971205771, 4366.214081465335, 4413.6910416270875, 3751.3997760358484, 3800.277947190025, 3803.2013277211818, 3811.656950874407, 3811.7331786774657, 5581.846256864858, 5638.182463542763, 5649.237352957381, 5656.547476201894, 5659.801906933238, 4860.881997140642, 5155.0978578748945, 5162.664426812245, 5184.170532714786, 5212.244224587452, 5697.743601537941, 5733.312002559678, 6088.4520393164385, 6172.321044685081, 6173.950428427178, 3946.9013274668077, 4114.423980642712, 4303.612674859278, 4321.891952701176, 4349.304111342201, 5931.584789064767, 6501.609903405811, 6514.250861150981, 6542.004688569984, 6593.604383736991, 4339.869803905888, 4359.106383191438, 4369.169857727022, 4381.780910954503, 4387.517373088957, 4189.916201675949, 4424.823007079745, 4447.288433850568, 4449.822007119744, 4461.620762235247, 4302.505211900609, 5170.3278573785165, 5170.37955445349, 5196.1034222508515, 5200.141976573898, 5920.2303700519515, 6228.636536270364, 6231.2522497300615, 6241.78153764616, 6269.7492100316385, 1282.9294388808519, 1351.2568087551808, 1457.1548501869102, 1498.4980031689288, 1537.2160198298948, 950.0, 1012.6101450941293, 1021.382063851374, 1031.566741968375, 1034.1158309645296, 4819.445763737145, 5589.189567512769, 5679.148127780866, 5850.5612079094235, 5861.941380586225, 6449.967750161313, 6450.6774661266745, 6483.286838447767, 6483.897737384656, 6507.9023814642815, 5616.241807356037, 5829.183914252008, 5834.299884013945, 5855.648661080349, 5870.706464676749, 2905.694902035298, 3232.3131459383517, 3373.5108409280515, 3382.340443613521, 3417.5044618530173, 6508.251551071593, 6573.769918052845, 6721.294264102296, 6753.763618273337, 6768.932310676831, 5872.26596675407, 6501.804945851632, 6626.906560417574, 6627.834304142435, 6676.332366763285, 6321.589096708607, 6404.263509696259, 6656.966715166393, 6666.0, 6689.595185011105, 6411.006294024433, 6414.134091897534, 6426.293107758236, 6451.258105317761, 6464.547481676237, 5117.334746482933, 6379.234491861006, 6384.489240860813, 6391.6804159792755, 6410.1987251593555, 6017.729202185825, 6141.815745527641, 6712.429443497357, 6752.561083529555, 6765.221999470124, 4345.174416860787, 4364.956350436582, 4369.815092453773, 4382.298832186835, 4408.184485869996, 5024.995000999887, 5583.385827558884, 6443.516736244706, 6461.838454038687, 6486.54594178403, 5258.605604579749, 5494.423085575957, 6211.409916057967, 6237.095621135, 6263.3736626337, 6170.482824789827, 6194.938050619617, 6201.410865967726, 6231.189945307081, 6267.903116954423, 5854.560907931837, 5874.412558744091, 6037.516998640011, 6079.209702738615, 6177.289611694533, 5298.15229563268, 6210.503159747119, 6260.154879091265, 6303.747850085945, 6346.524010699309, 5159.793608255778, 5387.299651045339, 6172.814815555541, 6185.6907154641185, 6208.3791620839365], "value": 4568.871727120789, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.1658559971236, 750.8085438213254, 757.2465396930052, 768.5696010234273, 787.6376866641343, 14856.851431485682, 15141.0, 15331.770023449657, 15519.84480155198, 15530.0, 14244.501442449491, 14314.0, 14316.856831431682, 14333.354999025043, 14345.497907573237, 743.8586668532988, 768.9269519395676, 913.808100298938, 935.4714586258742, 939.1876027236425, 888.2893685051965, 926.4626516620377, 927.0405130689737, 928.6563971330584, 931.1945167430158, 991.410110983967, 1001.1240164855751, 1002.1031177096494, 1002.3384566186319, 1002.5238011944341, 772.8377040821434, 798.4051881348374, 800.5076877720219, 993.2897977945768, 993.8608594796734, 592.3010847200302, 702.9753958611424, 732.9743458978963, 733.101950111115, 733.4425836364348, 14827.629309267246, 14903.925480372529, 14918.0, 14954.177520236382, 14955.626109347244, 12314.75370492594, 12487.438065287084, 12662.81005784914, 12763.808542871864, 12861.935690321488, 9921.75195620108, 10023.2482563808, 10033.698989030341, 10353.482325883751, 10547.208959328005, 3503.544539209912, 3539.5752509698746, 3559.181388280684, 3561.269939662363, 3584.0502266899034, 80588.59705701434, 81474.0, 82495.0, 82905.58547207285, 84736.0, 9495.57269922855, 9639.036096390446, 9688.515574221261, 9863.506824658738, 9972.052654997764, 21870.343889683336, 21901.561968760536, 21942.561148776935, 21944.780552194592, 21955.341339759834, 7276.272372762787, 7387.963060184665, 7411.444141689287, 7527.774166774896, 7529.284717951786, 4057.8985525361513, 4078.1435898461655, 4116.341385378325, 4120.835166593362, 4373.693841431133, 3523.1016090896655, 3643.908902277464, 3646.124930016777, 3652.36083685354, 3653.9269214616093, 516.6848222584221, 564.9858503985356, 622.4149299658307, 635.9523035772336, 671.9428848547831, 599.6432122886876, 604.4106995679177, 609.7225762278152, 610.9236345456818, 621.6177051113533, 6105.542084343692, 7343.596102214323, 7546.9622651887485, 7620.809479762939, 7845.529268243924, 499.46557183812973, 513.956313713331, 525.4561528817655, 568.9857753556112, 583.8511179649247, 3623.347797396494, 3682.521272234646, 3716.2381711749026, 3741.1702714659723, 3804.9239015220096, 70043.0, 72910.6354468235, 73028.2697173032, 73165.26834731584, 73261.26738732652, 67232.3276767226, 67760.0, 68142.0, 68298.29254268683, 70859.0, 57567.40946657327, 59590.70204648949, 61520.69239653773, 61718.82811718792, 62888.68555657192, 7903.288704016666, 7943.4836735612, 8034.196580341919, 8071.556064416513, 8143.6742530298125, 33848.49227261544, 38957.41563876601, 39520.0, 40098.79950600228, 40176.7991160054, 52343.69140771511, 53084.0, 53271.46728532665, 53762.92474150573, 54717.0, 10339.121174700234, 10492.213084018576, 10494.055535001886, 10655.147588193082, 10792.838107428552, 11685.474153662935, 11703.824442633197, 11714.414279286171, 11732.706682332668, 11902.226355286879, 10773.0, 10852.620158294421, 10878.945605271923, 11142.108631309313, 11194.0, 10284.485775711335, 10500.529925810546, 11015.724606884893, 11937.0, 12345.629631111082, 10469.476526173814, 10713.625023124154, 10819.296745711503, 10929.289596176222, 11169.441527923735, 9417.48203848795, 9632.373895696757, 9671.516424178904, 9727.645889720157, 9984.35101718386, 9159.862602061108, 9654.179394751243, 9682.806343873224, 9701.514924253901, 9791.020897910152], "value": 6656.762698122456, "unit": "score"}], "name": "dromaeo_css", "value": 7211.166798402534, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 111.0, 110.0, 113.0, 114.0, 119.0, 112.0, 115.0, 121.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 148.0, 180.0, 165.0, 117.0, 139.0, 121.0, 155.0, 155.0, 118.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [253.0, 251.0, 184.0, 186.0, 183.0, 186.0, 184.0, 181.0, 185.0, 184.0], "value": 197.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 87.0, 88.0, 56.0, 57.0, 60.0, 79.0, 83.0, 54.0], "value": 71.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 96.0, 135.0, 78.0, 78.0, 79.0, 122.0, 80.0, 77.0, 127.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 130.0, 122.0, 87.0, 90.0, 85.0, 90.0, 87.0, 92.0, 85.0], "value": 96.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 84.0, 83.0, 86.0, 84.0, 84.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 58.0, 57.0, 57.0, 56.0, 57.0, 76.0, 59.0, 55.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 79.0, 73.0, 69.0, 66.0, 68.0, 94.0, 95.0, 100.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 80.0, 82.0, 80.0, 81.0, 78.0, 83.0, 81.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 140.0, 139.0, 137.0, 150.0, 121.0, 157.0, 152.0, 191.0, 167.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 168.0, 165.0, 168.0, 168.0, 167.0, 167.0, 158.0, 168.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 71.0, 70.0, 69.0, 67.0, 68.0, 71.0, 67.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1502.1, "alertThreshold": 2.0}]} 10:16:02 INFO - Return code: 0 10:16:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:16:02 ERROR - # TBPL SUCCESS # 10:16:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:16:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:16:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:16:02 INFO - 2016-04-20 10:16:02.474 screenresolution[2048:17973] starting screenresolution argv=screenresolution get 10:16:02 INFO - 2016-04-20 10:16:02.476 screenresolution[2048:17973] Display 0: 1600x1200x32@60 10:16:02 INFO - 2016-04-20 10:16:02.482 screenresolution[2049:17976] starting screenresolution argv=screenresolution list 10:16:02 INFO - Available Modes on Display 0 10:16:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:16:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:16:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:16:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:16:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:16:02 INFO - Intel Iris: 10:16:02 INFO - Chipset Model: Intel Iris 10:16:02 INFO - Type: GPU 10:16:02 INFO - Bus: Built-In 10:16:02 INFO - VRAM (Dynamic, Max): 1536 MB 10:16:02 INFO - Vendor: Intel (0x8086) 10:16:02 INFO - Device ID: 0x0a2e 10:16:02 INFO - Revision ID: 0x0009 10:16:02 INFO - Displays: 10:16:02 INFO - Display: 10:16:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:16:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:16:02 INFO - Display Serial Number: 1600x1200 60 10:16:02 INFO - Main Display: Yes 10:16:02 INFO - Mirror: Off 10:16:02 INFO - Online: Yes 10:16:02 INFO - Rotation: Supported 10:16:02 INFO - Return code: 0 10:16:02 INFO - Running post-action listener: _resource_record_post_action 10:16:02 INFO - Running post-run listener: _resource_record_post_run 10:16:03 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 1634816; Write bytes: 695734784; Read time: 15; Write time: 1889 10:16:03 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 377567744; Write bytes: 371070464; Read time: 28115; Write time: 623 10:16:03 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1634816; Write bytes: 295367680; Read time: 15; Write time: 1163 10:16:03 INFO - Running post-run listener: _upload_blobber_files 10:16:03 INFO - Blob upload gear active. 10:16:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:16:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:16:04 INFO - (blobuploader) - INFO - Open directory for files ... 10:16:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:16:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:16:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:04 INFO - (blobuploader) - INFO - Done attempting. 10:16:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:16:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:16:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:05 INFO - (blobuploader) - INFO - Done attempting. 10:16:05 INFO - (blobuploader) - INFO - Iteration through files over. 10:16:05 INFO - Return code: 0 10:16:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:16:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:16:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2aa325e6f81a440466fa597c951aa29ad897ffc655aa06c3c78c78b2ba875312a14973c568b2a1b55a93a42397a71cd5d438a126f619ec494f404325e9755a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47c3283b7c34d43c2a1518d7ee9a2a98cc56e27d73a7c6f39c5860d5da627816f39c96c60ca49c3af511ed43a462abce1c1d617a3ccfb5e1935f35ecfb153354"} 10:16:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:16:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:16:05 INFO - Contents: 10:16:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2aa325e6f81a440466fa597c951aa29ad897ffc655aa06c3c78c78b2ba875312a14973c568b2a1b55a93a42397a71cd5d438a126f619ec494f404325e9755a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47c3283b7c34d43c2a1518d7ee9a2a98cc56e27d73a7c6f39c5860d5da627816f39c96c60ca49c3af511ed43a462abce1c1d617a3ccfb5e1935f35ecfb153354"} 10:16:05 INFO - Running post-run listener: copy_logs_to_upload_dir 10:16:05 INFO - Copying logs to upload dir... 10:16:05 INFO - mkdir: /builds/slave/test/build/upload/logs 10:16:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.532614 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-20 10:16:05.949240) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 10:16:05.953178) ========= 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.rXCVe0qBY8/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.H9PFf2TY3y/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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/Fx-Team/sha512/d2aa325e6f81a440466fa597c951aa29ad897ffc655aa06c3c78c78b2ba875312a14973c568b2a1b55a93a42397a71cd5d438a126f619ec494f404325e9755a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47c3283b7c34d43c2a1518d7ee9a2a98cc56e27d73a7c6f39c5860d5da627816f39c96c60ca49c3af511ed43a462abce1c1d617a3ccfb5e1935f35ecfb153354"} build_url:https://queue.taskcluster.net/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/NH1K_1A9RFi0U5O0U6tWsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2aa325e6f81a440466fa597c951aa29ad897ffc655aa06c3c78c78b2ba875312a14973c568b2a1b55a93a42397a71cd5d438a126f619ec494f404325e9755a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47c3283b7c34d43c2a1518d7ee9a2a98cc56e27d73a7c6f39c5860d5da627816f39c96c60ca49c3af511ed43a462abce1c1d617a3ccfb5e1935f35ecfb153354"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 10:16:05.982039) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:16:05.982455) ========= 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.rXCVe0qBY8/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.H9PFf2TY3y/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005028 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:16:06.031475) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 10:16:06.031844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 10:16:06.032282) ========= ========= Total master_lag: 0.18 =========