builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0002 starttime: 1467038438.73 results: success (0) buildid: 20160627053125 builduid: 91d531b5383642ed8679b7f776c5ef70 revision: 8664ad5c52883cb66cb9b46879eb062fb6600756 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 07:40:38.735270) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 07:40:38.735737) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 07:40:38.736046) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 07:40:38.762716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:40:38.763047) ========= 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.NkM8VaUQgb/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.o3ZG99IL0c/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-27 07:40:38-- 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-06-27 07:40:38 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178179 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:40:38.963840) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:40:38.964186) ========= 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.NkM8VaUQgb/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.o3ZG99IL0c/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.030740 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:40:39.017157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 07:40:39.017517) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8664ad5c52883cb66cb9b46879eb062fb6600756 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8664ad5c52883cb66cb9b46879eb062fb6600756 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NkM8VaUQgb/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.o3ZG99IL0c/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-27 07:40:39,093 truncating revision to first 12 chars 2016-06-27 07:40:39,093 Setting DEBUG logging. 2016-06-27 07:40:39,093 attempt 1/10 2016-06-27 07:40:39,093 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8664ad5c5288?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 07:40:40,261 unpacking tar archive at: mozilla-beta-8664ad5c5288/testing/mozharness/ program finished with exit code 0 elapsedTime=1.437599 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 07:40:40.477868) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 07:40:40.478360) ========= script_repo_revision: 8664ad5c52883cb66cb9b46879eb062fb6600756 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 07:40:40.478813) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 07:40:40.479200) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 07:40:40.497867) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-06-27 07:40:40.498296) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NkM8VaUQgb/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.o3ZG99IL0c/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 07:40:40 INFO - MultiFileLogger online at 20160627 07:40:40 in /builds/slave/test 07:40:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 07:40:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:40:40 INFO - {'append_to_log': False, 07:40:40 INFO - 'base_work_dir': '/builds/slave/test', 07:40:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:40:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:40:40 INFO - 'branch': 'Mozilla-Beta', 07:40:40 INFO - 'buildbot_json_path': 'buildprops.json', 07:40:40 INFO - 'config_files': ('talos/mac_config.py',), 07:40:40 INFO - 'default_actions': ('clobber', 07:40:40 INFO - 'read-buildbot-config', 07:40:40 INFO - 'download-and-extract', 07:40:40 INFO - 'populate-webroot', 07:40:40 INFO - 'create-virtualenv', 07:40:40 INFO - 'install', 07:40:40 INFO - 'run-tests'), 07:40:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:40:40 INFO - 'download_minidump_stackwalk': True, 07:40:40 INFO - 'download_symbols': 'ondemand', 07:40:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:40:40 INFO - 'tooltool.py': '/tools/tooltool.py', 07:40:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:40:40 INFO - '/tools/misc-python/virtualenv.py')}, 07:40:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:40:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:40:40 INFO - 'installer_path': 'installer.exe', 07:40:40 INFO - 'log_level': 'info', 07:40:40 INFO - 'log_name': 'talos', 07:40:40 INFO - 'log_to_console': True, 07:40:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:40:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:40:40 INFO - 'opt_config_files': (), 07:40:40 INFO - 'pip_index': False, 07:40:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:40:40 INFO - 'cmd': ('bash', 07:40:40 INFO - '-c', 07:40:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:40:40 INFO - 'enabled': True, 07:40:40 INFO - 'halt_on_failure': False, 07:40:40 INFO - 'name': 'check_screen_resolution'},), 07:40:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:40:40 INFO - 'cmd': ('bash', 07:40:40 INFO - '-c', 07:40:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:40:40 INFO - 'enabled': True, 07:40:40 INFO - 'halt_on_failure': False, 07:40:40 INFO - 'name': 'check_screen_resolution'},), 07:40:40 INFO - 'run_cmd_checks_enabled': True, 07:40:40 INFO - 'sps_profile': False, 07:40:40 INFO - 'sps_profile_interval': 0, 07:40:40 INFO - 'suite': 'dromaeojs', 07:40:40 INFO - 'system_bits': '32', 07:40:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:40:40 INFO - 'title': 't-yosemite-r7-0002', 07:40:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:40:40 INFO - 'use_talos_json': True, 07:40:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:40:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:40:40 INFO - 'work_dir': 'build'} 07:40:40 INFO - ##### 07:40:40 INFO - ##### Running clobber step. 07:40:40 INFO - ##### 07:40:40 INFO - Running pre-action listener: _resource_record_pre_action 07:40:40 INFO - Running main action method: clobber 07:40:40 INFO - rmtree: /builds/slave/test/build 07:40:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:40:42 INFO - Running post-action listener: _resource_record_post_action 07:40:42 INFO - ##### 07:40:42 INFO - ##### Running read-buildbot-config step. 07:40:42 INFO - ##### 07:40:42 INFO - Running pre-action listener: _resource_record_pre_action 07:40:42 INFO - Running main action method: read_buildbot_config 07:40:42 INFO - Using buildbot properties: 07:40:42 INFO - { 07:40:42 INFO - "project": "", 07:40:42 INFO - "product": "firefox", 07:40:42 INFO - "script_repo_revision": "production", 07:40:42 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 07:40:42 INFO - "repository": "", 07:40:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 07:40:42 INFO - "buildid": "20160627053125", 07:40:42 INFO - "pgo_build": "False", 07:40:42 INFO - "basedir": "/builds/slave/test", 07:40:42 INFO - "buildnumber": 44, 07:40:42 INFO - "slavename": "t-yosemite-r7-0002", 07:40:42 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:40:42 INFO - "platform": "yosemite_r7", 07:40:42 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:40:42 INFO - "branch": "mozilla-beta", 07:40:42 INFO - "repo_path": "releases/mozilla-beta", 07:40:42 INFO - "revision": "8664ad5c52883cb66cb9b46879eb062fb6600756", 07:40:42 INFO - "stage_platform": "macosx64", 07:40:42 INFO - "builduid": "91d531b5383642ed8679b7f776c5ef70", 07:40:42 INFO - "slavebuilddir": "test" 07:40:42 INFO - } 07:40:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 07:40:42 INFO - Running post-action listener: _resource_record_post_action 07:40:42 INFO - ##### 07:40:42 INFO - ##### Running download-and-extract step. 07:40:42 INFO - ##### 07:40:42 INFO - Running pre-action listener: _resource_record_pre_action 07:40:42 INFO - Running main action method: download_and_extract 07:40:42 INFO - mkdir: /builds/slave/test/build/tests 07:40:42 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')]} 07:40:42 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 07:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 07:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 07:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 07:40:49 INFO - Downloaded 1165 bytes. 07:40:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 07:40:49 INFO - Using the following test package requirements: 07:40:49 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 07:40:49 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:40:49 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 07:40:49 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:40:49 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 07:40:49 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:40:49 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:40:49 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 07:40:49 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 07:40:49 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:40:49 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 07:40:49 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:40:49 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 07:40:49 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:40:49 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 07:40:49 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:40:49 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 07:40:49 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 07:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:49 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:40:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:40:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:40:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 07:40:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 07:40:52 INFO - Downloaded 18344127 bytes. 07:40:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:40:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:40:55 INFO - Return code: 0 07:40:55 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:40:55 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')]} 07:40:55 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:40:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:40:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:40:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 07:40:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 07:41:11 INFO - Downloaded 18344127 bytes. 07:41:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:41:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:41:14 INFO - Return code: 0 07:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:14 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:41:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 07:41:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 07:41:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 07:41:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 07:41:15 INFO - Downloaded 10840145 bytes. 07:41:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:41:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:41:15 INFO - Return code: 0 07:41:15 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')]} 07:41:15 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 07:41:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:41:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:41:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 07:41:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 07:41:22 INFO - Downloaded 86228614 bytes. 07:41:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:41:22 INFO - mkdir: /builds/slave/test/properties 07:41:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:41:22 INFO - Writing to file /builds/slave/test/properties/build_url 07:41:22 INFO - Contents: 07:41:22 INFO - build_url:https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:41:24 INFO - Running post-action listener: _resource_record_post_action 07:41:24 INFO - Running post-action listener: set_extra_try_arguments 07:41:24 INFO - ##### 07:41:24 INFO - ##### Running populate-webroot step. 07:41:24 INFO - ##### 07:41:24 INFO - Running pre-action listener: _resource_record_pre_action 07:41:24 INFO - Running main action method: populate_webroot 07:41:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:41:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:41:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:41:24 INFO - '--tppagecycles', 07:41:24 INFO - '7'], 07:41:24 INFO - 'tests': ['tsvgm']}}, 07:41:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:41:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:41:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:41:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:41:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:41:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:41:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:24 INFO - 'talos_options': ['--disable-e10s'], 07:41:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:24 INFO - 'talos_options': ['--disable-e10s'], 07:41:24 INFO - 'tests': ['damp', 'tps']}, 07:41:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:24 INFO - 'tests': ['damp', 'tps']}, 07:41:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:41:24 INFO - 'tests': ['dromaeo_dom']}, 07:41:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:41:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:41:24 INFO - 'tests': ['a11yr', 07:41:24 INFO - 'ts_paint', 07:41:24 INFO - 'tpaint', 07:41:24 INFO - 'sessionrestore', 07:41:24 INFO - 'sessionrestore_no_auto_restore', 07:41:24 INFO - 'tabpaint']}, 07:41:24 INFO - 'other-e10s': {'tests': ['a11yr', 07:41:24 INFO - 'ts_paint', 07:41:24 INFO - 'tpaint', 07:41:24 INFO - 'sessionrestore', 07:41:24 INFO - 'sessionrestore_no_auto_restore', 07:41:24 INFO - 'tabpaint']}, 07:41:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:41:24 INFO - 'ts_paint', 07:41:24 INFO - 'tpaint', 07:41:24 INFO - 'sessionrestore', 07:41:24 INFO - 'sessionrestore_no_auto_restore', 07:41:24 INFO - 'tabpaint']}, 07:41:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:41:24 INFO - 'ts_paint', 07:41:24 INFO - 'tpaint', 07:41:24 INFO - 'sessionrestore', 07:41:24 INFO - 'sessionrestore_no_auto_restore', 07:41:24 INFO - 'tabpaint']}, 07:41:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:41:24 INFO - 'tests': ['a11yr', 07:41:24 INFO - 'ts_paint', 07:41:24 INFO - 'tpaint', 07:41:24 INFO - 'sessionrestore', 07:41:24 INFO - 'sessionrestore_no_auto_restore', 07:41:24 INFO - 'tabpaint']}, 07:41:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:41:24 INFO - 'tests': ['a11yr', 07:41:24 INFO - 'ts_paint', 07:41:24 INFO - 'tpaint', 07:41:24 INFO - 'sessionrestore', 07:41:24 INFO - 'sessionrestore_no_auto_restore', 07:41:24 INFO - 'tabpaint']}, 07:41:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:41:24 INFO - 'tests': ['tsvgx', 07:41:24 INFO - 'tsvgr_opacity', 07:41:24 INFO - 'tart', 07:41:24 INFO - 'tscrollx', 07:41:24 INFO - 'cart']}, 07:41:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:41:24 INFO - 'tsvgr_opacity', 07:41:24 INFO - 'tart', 07:41:24 INFO - 'tscrollx', 07:41:24 INFO - 'cart']}, 07:41:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:24 INFO - 'talos_options': ['--disable-e10s'], 07:41:24 INFO - 'tests': ['tp5o']}, 07:41:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:24 INFO - 'tests': ['tp5o']}, 07:41:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:24 INFO - 'talos_options': ['--disable-e10s', 07:41:24 INFO - '--xperf_path', 07:41:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:24 INFO - 'tests': ['tp5n']}, 07:41:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:24 INFO - 'talos_options': ['--xperf_path', 07:41:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:24 INFO - 'tests': ['tp5n']}}, 07:41:24 INFO - 'talos.zip': {'path': '', 07:41:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:41:24 INFO - Running post-action listener: _resource_record_post_action 07:41:24 INFO - ##### 07:41:24 INFO - ##### Running create-virtualenv step. 07:41:24 INFO - ##### 07:41:24 INFO - Running pre-action listener: _resource_record_pre_action 07:41:24 INFO - Running main action method: create_virtualenv 07:41:24 INFO - Creating virtualenv /builds/slave/test/build/venv 07:41:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:41:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:41:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:41:24 INFO - Using real prefix '/tools/python27' 07:41:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:41:25 INFO - Installing distribute.............................................................................................................................................................................................done. 07:41:28 INFO - Installing pip.................done. 07:41:28 INFO - Return code: 0 07:41:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca06a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca16420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff621d78e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a5e00>, '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 0x10c70edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a0b20>, '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.NkM8VaUQgb/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.o3ZG99IL0c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 07:41:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:41:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkM8VaUQgb/Render', 07:41:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:28 INFO - 'HOME': '/Users/cltbld', 07:41:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:28 INFO - 'LOGNAME': 'cltbld', 07:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:28 INFO - 'MOZ_NO_REMOTE': '1', 07:41:28 INFO - 'NO_EM_RESTART': '1', 07:41:28 INFO - 'PAGER': '/bin/cat', 07:41:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:28 INFO - 'PWD': '/builds/slave/test', 07:41:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:28 INFO - 'SHELL': '/bin/bash', 07:41:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o3ZG99IL0c/Listeners', 07:41:28 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 07:41:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:28 INFO - 'USER': 'cltbld', 07:41:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:28 INFO - 'XPC_FLAGS': '0x0', 07:41:28 INFO - 'XPC_SERVICE_NAME': '0', 07:41:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:41:28 INFO - Cleaning up... 07:41:28 INFO - Return code: 0 07:41:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca06a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca16420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff621d78e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a5e00>, '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 0x10c70edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a0b20>, '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.NkM8VaUQgb/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.o3ZG99IL0c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 07:41:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:41:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkM8VaUQgb/Render', 07:41:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:28 INFO - 'HOME': '/Users/cltbld', 07:41:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:28 INFO - 'LOGNAME': 'cltbld', 07:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:28 INFO - 'MOZ_NO_REMOTE': '1', 07:41:28 INFO - 'NO_EM_RESTART': '1', 07:41:28 INFO - 'PAGER': '/bin/cat', 07:41:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:28 INFO - 'PWD': '/builds/slave/test', 07:41:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:28 INFO - 'SHELL': '/bin/bash', 07:41:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o3ZG99IL0c/Listeners', 07:41:28 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 07:41:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:28 INFO - 'USER': 'cltbld', 07:41:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:28 INFO - 'XPC_FLAGS': '0x0', 07:41:28 INFO - 'XPC_SERVICE_NAME': '0', 07:41:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:28 INFO - Downloading/unpacking psutil>=0.7.1 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:41:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:31 INFO - Installing collected packages: psutil 07:41:31 INFO - Running setup.py install for psutil 07:41:31 INFO - building 'psutil._psutil_osx' extension 07:41:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:41:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:41:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:41:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:41:32 INFO - building 'psutil._psutil_posix' extension 07:41:32 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 07:41:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:41:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:41:32 INFO - ^ 07:41:32 INFO - 1 warning generated. 07:41:32 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 07:41:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:32 INFO - Successfully installed psutil 07:41:32 INFO - Cleaning up... 07:41:32 INFO - Return code: 0 07:41:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:32 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 0x10ca06a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca16420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff621d78e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a5e00>, '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 0x10c70edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a0b20>, '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.NkM8VaUQgb/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.o3ZG99IL0c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 07:41:32 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 07:41:32 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 07:41:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkM8VaUQgb/Render', 07:41:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:32 INFO - 'HOME': '/Users/cltbld', 07:41:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:32 INFO - 'LOGNAME': 'cltbld', 07:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:32 INFO - 'MOZ_NO_REMOTE': '1', 07:41:32 INFO - 'NO_EM_RESTART': '1', 07:41:32 INFO - 'PAGER': '/bin/cat', 07:41:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:32 INFO - 'PWD': '/builds/slave/test', 07:41:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:32 INFO - 'SHELL': '/bin/bash', 07:41:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o3ZG99IL0c/Listeners', 07:41:32 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 07:41:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:32 INFO - 'USER': 'cltbld', 07:41:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:32 INFO - 'XPC_FLAGS': '0x0', 07:41:32 INFO - 'XPC_SERVICE_NAME': '0', 07:41:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:41:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:41:36 INFO - Installing collected packages: mozsystemmonitor 07:41:36 INFO - Running setup.py install for mozsystemmonitor 07:41:36 INFO - Successfully installed mozsystemmonitor 07:41:36 INFO - Cleaning up... 07:41:36 INFO - Return code: 0 07:41:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca06a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca16420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff621d78e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a5e00>, '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 0x10c70edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a0b20>, '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.NkM8VaUQgb/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.o3ZG99IL0c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 07:41:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:41:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkM8VaUQgb/Render', 07:41:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:36 INFO - 'HOME': '/Users/cltbld', 07:41:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:36 INFO - 'LOGNAME': 'cltbld', 07:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:36 INFO - 'MOZ_NO_REMOTE': '1', 07:41:36 INFO - 'NO_EM_RESTART': '1', 07:41:36 INFO - 'PAGER': '/bin/cat', 07:41:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:36 INFO - 'PWD': '/builds/slave/test', 07:41:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:36 INFO - 'SHELL': '/bin/bash', 07:41:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o3ZG99IL0c/Listeners', 07:41:36 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 07:41:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:36 INFO - 'USER': 'cltbld', 07:41:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:36 INFO - 'XPC_FLAGS': '0x0', 07:41:36 INFO - 'XPC_SERVICE_NAME': '0', 07:41:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:36 INFO - Downloading/unpacking blobuploader==1.2.4 07:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:38 INFO - Downloading blobuploader-1.2.4.tar.gz 07:41:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:41:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:41:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:40 INFO - Downloading docopt-0.6.1.tar.gz 07:41:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:41:40 INFO - Installing collected packages: blobuploader, requests, docopt 07:41:40 INFO - Running setup.py install for blobuploader 07:41:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:41:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:41:40 INFO - Running setup.py install for requests 07:41:40 INFO - Running setup.py install for docopt 07:41:41 INFO - Successfully installed blobuploader requests docopt 07:41:41 INFO - Cleaning up... 07:41:41 INFO - Return code: 0 07:41:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca06a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca16420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff621d78e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a5e00>, '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 0x10c70edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a0b20>, '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.NkM8VaUQgb/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.o3ZG99IL0c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 07:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:41:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkM8VaUQgb/Render', 07:41:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:41 INFO - 'HOME': '/Users/cltbld', 07:41:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:41 INFO - 'LOGNAME': 'cltbld', 07:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:41 INFO - 'MOZ_NO_REMOTE': '1', 07:41:41 INFO - 'NO_EM_RESTART': '1', 07:41:41 INFO - 'PAGER': '/bin/cat', 07:41:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:41 INFO - 'PWD': '/builds/slave/test', 07:41:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:41 INFO - 'SHELL': '/bin/bash', 07:41:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o3ZG99IL0c/Listeners', 07:41:41 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 07:41:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:41 INFO - 'USER': 'cltbld', 07:41:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:41 INFO - 'XPC_FLAGS': '0x0', 07:41:41 INFO - 'XPC_SERVICE_NAME': '0', 07:41:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:41:41 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-etOcpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:41:41 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-F8UP5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:41:41 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-vj0Sap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:41:41 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-WGp3dT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:41:41 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-0wG_i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:41:41 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-OSSJx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:41:42 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-3P5656-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:41:42 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-UJE4mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:41:42 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ljhSi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:41:42 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-H_O4Ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:41:42 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-UlgPY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:41:42 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-5LgVFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:41:42 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-52YSkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:41:42 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-FmW_w5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:42 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ryyruv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:41:43 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-SrXPd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:41:43 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-mMtASA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:41:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:41:43 INFO - Running setup.py install for manifestparser 07:41:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:41:43 INFO - Running setup.py install for mozcrash 07:41:43 INFO - Running setup.py install for mozdebug 07:41:43 INFO - Running setup.py install for mozdevice 07:41:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:41:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:41:43 INFO - Running setup.py install for mozfile 07:41:43 INFO - Running setup.py install for mozhttpd 07:41:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:41:44 INFO - Running setup.py install for mozinfo 07:41:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:41:44 INFO - Running setup.py install for mozInstall 07:41:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:41:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:41:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:41:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:41:44 INFO - Running setup.py install for mozleak 07:41:44 INFO - Running setup.py install for mozlog 07:41:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:41:44 INFO - Running setup.py install for moznetwork 07:41:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:41:44 INFO - Running setup.py install for mozprocess 07:41:45 INFO - Running setup.py install for mozprofile 07:41:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:41:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:41:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:41:45 INFO - Running setup.py install for mozrunner 07:41:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:41:45 INFO - Running setup.py install for mozscreenshot 07:41:45 INFO - Running setup.py install for moztest 07:41:45 INFO - Running setup.py install for mozversion 07:41:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:41:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:41:45 INFO - Cleaning up... 07:41:45 INFO - Return code: 0 07:41:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca06a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca16420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff621d78e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a5e00>, '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 0x10c70edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a0b20>, '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.NkM8VaUQgb/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.o3ZG99IL0c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 07:41:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:41:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkM8VaUQgb/Render', 07:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:45 INFO - 'HOME': '/Users/cltbld', 07:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:45 INFO - 'LOGNAME': 'cltbld', 07:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:45 INFO - 'MOZ_NO_REMOTE': '1', 07:41:45 INFO - 'NO_EM_RESTART': '1', 07:41:45 INFO - 'PAGER': '/bin/cat', 07:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:45 INFO - 'PWD': '/builds/slave/test', 07:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:45 INFO - 'SHELL': '/bin/bash', 07:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o3ZG99IL0c/Listeners', 07:41:45 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 07:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:45 INFO - 'USER': 'cltbld', 07:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:45 INFO - 'XPC_FLAGS': '0x0', 07:41:45 INFO - 'XPC_SERVICE_NAME': '0', 07:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:41:46 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-dJBI_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:41:46 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-TEwURZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:41:46 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-0AkozT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:41:46 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-CXlv_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:41:46 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-tpaEyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:41:46 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-DQDVR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:41:46 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-CaABlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:41:46 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-nUvbEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:41:46 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-GbWXyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:41:47 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)) 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:41:47 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-za92CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:41:47 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-dhbRVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:41:47 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-SrSHa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:41:47 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-em8Z8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:41:47 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-kTaRlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:47 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-vRkw2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:41:47 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-mpRU2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:41:47 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-w7vphC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:41:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:50 INFO - Downloading blessings-1.6.tar.gz 07:41:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:41:50 INFO - Installing collected packages: blessings 07:41:50 INFO - Running setup.py install for blessings 07:41:50 INFO - Successfully installed blessings 07:41:50 INFO - Cleaning up... 07:41:50 INFO - Return code: 0 07:41:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:41:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:41:51 INFO - Reading from file tmpfile_stdout 07:41:51 INFO - Current package versions: 07:41:51 INFO - blessings == 1.6 07:41:51 INFO - blobuploader == 1.2.4 07:41:51 INFO - docopt == 0.6.1 07:41:51 INFO - manifestparser == 1.1 07:41:51 INFO - mozInstall == 1.12 07:41:51 INFO - mozcrash == 0.17 07:41:51 INFO - mozdebug == 0.1 07:41:51 INFO - mozdevice == 0.48 07:41:51 INFO - mozfile == 1.2 07:41:51 INFO - mozhttpd == 0.7 07:41:51 INFO - mozinfo == 0.9 07:41:51 INFO - mozleak == 0.1 07:41:51 INFO - mozlog == 3.1 07:41:51 INFO - moznetwork == 0.27 07:41:51 INFO - mozprocess == 0.22 07:41:51 INFO - mozprofile == 0.28 07:41:51 INFO - mozrunner == 6.11 07:41:51 INFO - mozscreenshot == 0.1 07:41:51 INFO - mozsystemmonitor == 0.0 07:41:51 INFO - moztest == 0.7 07:41:51 INFO - mozversion == 1.4 07:41:51 INFO - psutil == 3.1.1 07:41:51 INFO - requests == 1.2.3 07:41:51 INFO - wsgiref == 0.1.2 07:41:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:51 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 0x10ca06a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca16420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff621d78e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a5e00>, '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 0x10c70edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a0b20>, '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.NkM8VaUQgb/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.o3ZG99IL0c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 07:41:51 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 07:41:51 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 07:41:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkM8VaUQgb/Render', 07:41:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:51 INFO - 'HOME': '/Users/cltbld', 07:41:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:51 INFO - 'LOGNAME': 'cltbld', 07:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:51 INFO - 'MOZ_NO_REMOTE': '1', 07:41:51 INFO - 'NO_EM_RESTART': '1', 07:41:51 INFO - 'PAGER': '/bin/cat', 07:41:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:51 INFO - 'PWD': '/builds/slave/test', 07:41:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:51 INFO - 'SHELL': '/bin/bash', 07:41:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o3ZG99IL0c/Listeners', 07:41:51 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 07:41:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:51 INFO - 'USER': 'cltbld', 07:41:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:51 INFO - 'XPC_FLAGS': '0x0', 07:41:51 INFO - 'XPC_SERVICE_NAME': '0', 07:41:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:41:51 INFO - Cleaning up... 07:41:51 INFO - Return code: 0 07:41:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca06a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca16420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff621d78e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a5e00>, '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 0x10c70edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a0b20>, '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.NkM8VaUQgb/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.o3ZG99IL0c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 07:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:41:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkM8VaUQgb/Render', 07:41:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:51 INFO - 'HOME': '/Users/cltbld', 07:41:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:51 INFO - 'LOGNAME': 'cltbld', 07:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:51 INFO - 'MOZ_NO_REMOTE': '1', 07:41:51 INFO - 'NO_EM_RESTART': '1', 07:41:51 INFO - 'PAGER': '/bin/cat', 07:41:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:51 INFO - 'PWD': '/builds/slave/test', 07:41:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:51 INFO - 'SHELL': '/bin/bash', 07:41:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o3ZG99IL0c/Listeners', 07:41:51 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 07:41:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:51 INFO - 'USER': 'cltbld', 07:41:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:51 INFO - 'XPC_FLAGS': '0x0', 07:41:51 INFO - 'XPC_SERVICE_NAME': '0', 07:41:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:51 INFO - Downloading/unpacking jsonschema 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:41:54 INFO - Downloading/unpacking functools32 (from jsonschema) 07:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:54 INFO - Downloading functools32-3.2.3-2.tar.gz 07:41:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:41:54 INFO - warning: no files found matching '*.txt' 07:41:54 INFO - no previously-included directories found matching 'build' 07:41:54 INFO - no previously-included directories found matching 'dist' 07:41:54 INFO - no previously-included directories found matching '.git*' 07:41:54 INFO - Installing collected packages: jsonschema, functools32 07:41:54 INFO - Running setup.py install for functools32 07:41:54 INFO - warning: no files found matching '*.txt' 07:41:54 INFO - no previously-included directories found matching 'build' 07:41:54 INFO - no previously-included directories found matching 'dist' 07:41:54 INFO - no previously-included directories found matching '.git*' 07:41:54 INFO - Successfully installed jsonschema functools32 07:41:54 INFO - Cleaning up... 07:41:54 INFO - Return code: 0 07:41:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca06a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca16420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff621d78e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a5e00>, '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 0x10c70edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a0b20>, '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.NkM8VaUQgb/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.o3ZG99IL0c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 07:41:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:41:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkM8VaUQgb/Render', 07:41:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:54 INFO - 'HOME': '/Users/cltbld', 07:41:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:54 INFO - 'LOGNAME': 'cltbld', 07:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:54 INFO - 'MOZ_NO_REMOTE': '1', 07:41:54 INFO - 'NO_EM_RESTART': '1', 07:41:54 INFO - 'PAGER': '/bin/cat', 07:41:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:54 INFO - 'PWD': '/builds/slave/test', 07:41:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:54 INFO - 'SHELL': '/bin/bash', 07:41:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o3ZG99IL0c/Listeners', 07:41:54 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 07:41:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:54 INFO - 'USER': 'cltbld', 07:41:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:54 INFO - 'XPC_FLAGS': '0x0', 07:41:54 INFO - 'XPC_SERVICE_NAME': '0', 07:41:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:55 INFO - Downloading/unpacking flake8 07:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:41:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:41:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:41:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:41:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:41:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:41:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:41:58 INFO - no previously-included directories found matching 'docs/_build' 07:41:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:41:59 INFO - Running setup.py install for pep8 07:41:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:41:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:41:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:41:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:41:59 INFO - no previously-included directories found matching 'docs/_build' 07:41:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:41:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:41:59 INFO - Cleaning up... 07:41:59 INFO - Return code: 0 07:41:59 INFO - Running post-action listener: _resource_record_post_action 07:41:59 INFO - Running post-action listener: _start_resource_monitoring 07:41:59 INFO - Starting resource monitoring. 07:41:59 INFO - ##### 07:41:59 INFO - ##### Running install step. 07:41:59 INFO - ##### 07:41:59 INFO - Running pre-action listener: _resource_record_pre_action 07:41:59 INFO - Running main action method: install 07:41:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:41:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:41:59 INFO - Reading from file tmpfile_stdout 07:41:59 INFO - Detecting whether we're running mozinstall >=1.0... 07:41:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:41:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:41:59 INFO - Reading from file tmpfile_stdout 07:41:59 INFO - Output received: 07:41:59 INFO - Usage: mozinstall [options] installer 07:41:59 INFO - Options: 07:41:59 INFO - -h, --help show this help message and exit 07:41:59 INFO - -d DEST, --destination=DEST 07:41:59 INFO - Directory to install application into. [default: 07:41:59 INFO - "/builds/slave/test"] 07:41:59 INFO - --app=APP Application being installed. [default: firefox] 07:41:59 INFO - mkdir: /builds/slave/test/build/application 07:41:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:41:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:42:21 INFO - Reading from file tmpfile_stdout 07:42:21 INFO - Output received: 07:42:21 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:42:21 INFO - Running post-action listener: _resource_record_post_action 07:42:21 INFO - ##### 07:42:21 INFO - ##### Running run-tests step. 07:42:21 INFO - ##### 07:42:21 INFO - Running pre-action listener: _resource_record_pre_action 07:42:21 INFO - Running main action method: run_tests 07:42:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:42:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:42:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:42:21 INFO - 2016-06-27 07:42:21.742 screenresolution[1642:7652] starting screenresolution argv=screenresolution get 07:42:21 INFO - 2016-06-27 07:42:21.745 screenresolution[1642:7652] Display 0: 1600x1200x32@60 07:42:21 INFO - 2016-06-27 07:42:21.751 screenresolution[1643:7655] starting screenresolution argv=screenresolution list 07:42:21 INFO - Available Modes on Display 0 07:42:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:42:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:42:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:42:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:42:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:42:21 INFO - Intel Iris: 07:42:21 INFO - Chipset Model: Intel Iris 07:42:21 INFO - Type: GPU 07:42:21 INFO - Bus: Built-In 07:42:21 INFO - VRAM (Dynamic, Max): 1536 MB 07:42:21 INFO - Vendor: Intel (0x8086) 07:42:21 INFO - Device ID: 0x0a2e 07:42:21 INFO - Revision ID: 0x0009 07:42:21 INFO - Displays: 07:42:21 INFO - Display: 07:42:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:42:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:42:21 INFO - Display Serial Number: 1600x1200 60 07:42:21 INFO - Main Display: Yes 07:42:21 INFO - Mirror: Off 07:42:21 INFO - Online: Yes 07:42:21 INFO - Rotation: Supported 07:42:21 INFO - Return code: 0 07:42:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:42:21 INFO - Python 2.7.3 07:42:21 INFO - Return code: 0 07:42:21 INFO - grabbing minidump binary from tooltool 07:42: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')]} 07:42:21 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 0x10c8a5e00>, '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 0x10c70edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:42:21 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 07:42:21 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 07:42:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:42:22 INFO - Return code: 0 07:42:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:42:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:42:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:42:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:42:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:42:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:42:23 INFO - Return code: 0 07:42:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 07:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0002 --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 07:42:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkM8VaUQgb/Render', 07:42:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:23 INFO - 'HOME': '/Users/cltbld', 07:42:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:23 INFO - 'LOGNAME': 'cltbld', 07:42:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:42:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:23 INFO - 'MOZ_NO_REMOTE': '1', 07:42:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:42:23 INFO - 'NO_EM_RESTART': '1', 07:42:23 INFO - 'PAGER': '/bin/cat', 07:42:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:23 INFO - 'PWD': '/builds/slave/test', 07:42:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:42:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:23 INFO - 'SHELL': '/bin/bash', 07:42:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o3ZG99IL0c/Listeners', 07:42:23 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 07:42:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:23 INFO - 'USER': 'cltbld', 07:42:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:23 INFO - 'XPC_FLAGS': '0x0', 07:42:23 INFO - 'XPC_SERVICE_NAME': '0', 07:42:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 07:42:23 INFO - mozversion application_buildid: 20160627053125 07:42:23 INFO - mozversion application_changeset: 8664ad5c52883cb66cb9b46879eb062fb6600756 07:42:23 INFO - mozversion application_display_name: Firefox 07:42:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:42:23 INFO - mozversion application_name: Firefox 07:42:23 INFO - mozversion application_remotingname: firefox 07:42:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:42:23 INFO - mozversion application_vendor: Mozilla 07:42:23 INFO - mozversion application_version: 48.0 07:42:23 INFO - mozversion platform_buildid: 20160627053125 07:42:23 INFO - mozversion platform_changeset: 8664ad5c52883cb66cb9b46879eb062fb6600756 07:42:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:42:23 INFO - mozversion platform_version: 48.0 07:42:23 INFO - using testdate: 1467038543 07:42:23 INFO - actual date: 1467038543 07:42:23 INFO - starting webserver on 'localhost:49276' 07:42:23 INFO - SUITE-START | Running 2 tests 07:42:23 INFO - TEST-START | dromaeo_css 07:42:23 INFO - operating with platform_type : mac_ 07:42:23 INFO - Initialising browser for dromaeo_css test... 07:42:23 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpGdGFb_/profile http://localhost:49276/getInfo.html) 07:42:25 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 07:42:25 INFO - PROCESS | 1661 | colorDepth:24 07:42:25 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 07:42:25 INFO - PROCESS | 1661 | __metrics 07:42:25 INFO - PROCESS | 1661 | 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" 07:42:25 ERROR - PROCESS | 1661 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:42:26 INFO - TEST-INFO | 1661: exit 0 07:42:26 INFO - Browser initialized. 07:42:26 INFO - Running cycle 1/1 for dromaeo_css test... 07:42:26 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpGdGFb_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:42:38 INFO - PROCESS | 1664 | RSS: Main: 161918976 07:42:38 INFO - PROCESS | 1664 | 07:43:29 INFO - PROCESS | 1664 | 1467038609563 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] 07:45:39 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 07:45:40 INFO - PROCESS | 1664 | RSS: Main: 328794112 07:45:40 INFO - PROCESS | 1664 | 07:48:43 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 07:48:44 INFO - PROCESS | 1664 | RSS: Main: 297381888 07:48:44 INFO - PROCESS | 1664 | 07:51:46 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 07:51:46 INFO - PROCESS | 1664 | RSS: Main: 302841856 07:51:46 INFO - PROCESS | 1664 | 07:54:48 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 07:54:49 INFO - PROCESS | 1664 | RSS: Main: 298909696 07:54:49 INFO - PROCESS | 1664 | 07:57:52 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 07:57:53 INFO - PROCESS | 1664 | RSS: Main: 263798784 07:57:53 INFO - PROCESS | 1664 | 08:00:55 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 08:00:55 INFO - PROCESS | 1664 | RSS: Main: 311627776 08:00:55 INFO - PROCESS | 1664 | 08:00:55 INFO - PROCESS | 1664 | __start_tp_report 08:00:55 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 08:00:55 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 08:00:55 INFO - PROCESS | 1664 | |i|pagename|runs| 08:00:55 INFO - PROCESS | 1664 | |0;dojo.html;3582.4089025310823;3645.6901163401108;3655.0862284428895;3655.4151335786273;3701.5743189533196;5954.612950158236;6005.669688167149;6036.0644100164545;6036.879262414744;6049.485793707529;6078.300995385532;6085.087236914465;6087.969560152204;6092.208012958309;6093.055576385667;5333.093374126408;5393.541548968343;5425.538829199523;5462.617616766828;5514.283143191399;5457.699826509541;5487.314085739283;5514.751836167362;5520.171974203861;5523.309586301712;5430.67415955044;5491.917621235684;5502.532284755801;5513.972430137844;5521.723913804314;5472.179173124024;5487.368952570466;5502.80740174096;5518.834434966958;5532.474414930575;5325.573954083664;5353.625246232766;5362.034833729927;5456.83629491112;5482.835514934558;5855.443732845373;5926.525877929756;5949.672767997802;5960.582759206857;5998.7600495980105;6305.968470157666;6307.842303942438;6347.1114044033875;6349.4602958748565;6371;6199.473044791153;6295.401936815995;6351.87296254077;6357.936420635827;6374.075759014917;6135.355787642323;6156.199694039791;6200.348963358872;6204.224471941007;6218.751249950042;6520.9347906520325;6542.182227221598;6545.967270163714;6551.508636852255;6556.082148499214;5235.240890070919;6293.685315734195;6339.809805705836;6340.365963403715;6381.936180638227;6314;6334.651594162273;6339.778107766206;6347.39699728525;6367.904481432783;6294.527910406738;6340.397662222082;6360.809175724736;6364.172657554488;6395.680215989182;6269.279032911182;6294.118823364733;6330.651814150174;6332;6392.232932048091;5079.492050794891;5122.769475373617;5129.333186685707;5134.589232861362;5141.280220769096;4585.403897493371;4622.896582055157;4656.4412270527755;4657.906841863144;4682.157211701926;5104.464031276662;6039.54703397247;6098.573099883054;6136.539759517965;6144.262688477412;6379.936200638027;6383.680815959184;6401.231852177769;6411.551191416649;6418.679066046679;5936.109583562414;6026.517878569792;6088.452039316483;6102.176206212193;6105.908411373833;5589.636673616202;5599.8880022400135;5633;5645.266115404971;5671.943280567141;6612.426182817566;6645.3022432643875;6661.300563440769;6668.266490685924;6670.466362691071;6315.242170939517;6326.9683651581445;6328.968355158195;6374;6413.935860641333;6614.801555953329;6622.966885165543;6629.801105966829;6651.667416629246;6652.73389064432;6332.968335158294;6345.302016778243;6349.333320001333;6350.7142178603;6352.205974253218;5347.786088556414;6321.52588555851;6334.303226644974;6356.5232607555545;6378.649174295459;6353.650549219838;6355;6359.7456101755415;6365.840853978688;6374.458171055512;6225.221847269091;6284.748610055546;6358.1734374531015;6370.74517019314;6404.135441715309;6108.72510737009;6133.478654314434;6198.783042593487;6236.095766113797;6286.465650419766;5258.526732594085;6324.968375158279;6329.050642403677;6343.429091381798;6348.301686814539;6195.132681424694;6212.1303017578475;6222.439980401786;6327.778527751507;6332.145160403286 08:00:55 INFO - PROCESS | 1664 | |1;ext.html;538.0462019989976;541.8293237630148;580.3789944759108;604.5012864386882;608.846236382056;30663.69336306639;32426.351472970528;33033;40624.39063414051;40640.78077657668;35257.82371088141;43751;43929.56070439295;43995.34006989898;44015.339769903396;8997.145271199226;9714.805703885935;9938.105570498654;9941.204703623693;11759.941200293986;11762.705932351717;11888.702782430466;11888.821667674993;11898.702532436715;11933.940330298336;11864.347460889647;11929.22460040099;11932;11958.820617690742;11971.880281197164;11884.821727674092;11887.702807429798;11892.524299028028;11896.524139034429;11901.583444579399;11716.23844450108;12172.147949643528;12201.023918086532;12203.816942745865;12206.511739530408;42682.146357073;43187;43206.56793432057;43214.78392608017;43302.783486082684;3318.4856347266214;3377.746668999835;3499.2826470573473;3567.928641427183;3722.3858063419502;29851.85074074616;30051.248718781986;31066.844665776527;31270.687293127234;31976;2783.5268004439295;2786.874590643426;2793.6368272124696;2858.1282708773815;2901.419716056776;408546;409079.9546002251;409776;409832;411095;37729.62270377261;64057.03914441287;64854.02718959219;65075.698486030014;65199.67400162969;37188.442173367424;37265.44101838474;37342.25315493675;37385.81307093447;37423;13322.467101316033;16168.75746863798;16190.947588406716;16191.514254572146;16217.51347459578;13081.803772943413;13955.372008259652;13960;13985.650358741113;14009.85990140106;8352.415330926899;8398;8432.367572432093;8441.366897482714;8520.61657225414;3540.91147721309;3583.94624080639;3591.5331006968927;3591.802450865175;3615.331163734665;952.8189643967625;1032.4837581209395;1107.4684151607112;1120.5293776613678;1171.1684703860185;30839.69160308413;30845.537316940263;31048.73988231203;31519.212019699233;31660.366792664478;1090.8200146975819;1189.9881001190051;1219.116140797932;1257.955896605815;1258.8426446694164;12980.35098245084;15561.766573501407;15781.515687820192;16193.757093643604;16246.025238485729;654605;656850;665197.6740116269;666234;668346;64296.67851660712;64873;64953;65045.02432463517;65152;1459.3724698379585;1512.7201467728505;1560.8127024757102;1571.7406627906496;1602.4791942618695;30485.847570762893;32315.35369292554;32925.67074329226;33188.1702957428;33472.497912530845;58451;58967.41032589619;59346.70326648339;59471.70264148652;59524.10713839209;511182;616942;618215;618619;619639;45393.77303113463;45900.540994589624;47312;47330.29004564865;47401.15593064289;49039;49366.25950610815;49419.88427562643;50386.49613503965;50568;39056.609433905294;40155.799221003705;40511.79744101378;40600;41576.58423415727;39503.407448888865;39546.011349716486;39719;40663.79668101641;40665.39001914914;39417.62038328645;39740.40389394104;39985.600143998185;40166.39750403805;40780.59219407768;33741.493877592344;34460.00329952193;35390.82304588461;35410.822945885106;35557.1110722234;21907.478605977925;22020.669689954342;26270.343241419116;26718.332041699112;28202.85898570494 08:00:55 INFO - PROCESS | 1664 | |2;jquery.html;373.81869793150315;419.314420921793;420.4009286766357;421.39740171554683;434.5415586556182;14558.490452834152;20778.480537986557;21494.570108597818;21546.89226553867;21704.457388565294;20491.590168196628;20892.850893200906;21342.786572134275;21376.465588360297;21385.144594216214;5886.705664716768;5903.144044113601;6175.62946223228;6179.165812615307;6183.7217325220245;6076.574639775217;6136.140940268366;6137.232845894263;6161.537884658646;6163.013917773157;4498.775061246941;5755.338136114337;6392.16901802765;6704.865902681943;6712.899306510406;5492.286002819648;6601.585728444004;6662;6662.1339225900565;6675.966620166892;5972.820815375502;5990.7903223386975;5990.790322338741;6016.458518733291;6016.699165041774;23169.652455213185;24375.14686985947;26096.34759131018;26258.34354141143;26516.337091572674;2029.401326608654;2219.6004719150546;2382.0948039744785;2789.860506974643;2824.963164598045;14941.626459338495;14955.551333460013;14957.252137393087;15113.697726045417;15356.616084597863;1818.863585231113;1826.7625208722914;1842.6959551673958;1879.7086451600023;1886.9245230190777;103969.44045839319;105889.47055264752;114536;115609;116649;11252;11413.315201087962;11637;11764.235324703866;11802.645920622395;13081.626429224985;13706.725865482835;13978;14735.263236838115;14817.481388151364;7314.670839812221;9054;9089;9138.54307284633;9252.491112988715;9261.953690231505;9271.860922086174;9282.48946307946;9293.210077143518;9326.487043212554;6903;7038.155421349471;7041.507094503438;7053.188883278489;7120.181179164359;1977.7725561560605;1979.9307024254083;1983.603279344137;1993.8604297699312;2039.9694004589944;1013.5135135135176;1035.2649618770756;1053.4311471805293;1097.8408130820985;1103.7516558774373;19611.803881961285;21601.67597486039;21609.67585486219;21885.67171492429;22044.88977555134;1028.0695970147028;1064.6060957445795;1071.8552995345528;1073.5521626737961;1077.8814330423647;11231.21381503287;11656.94171529154;11717.941410292893;11724.88275117255;11764.647060588197;588961;615153;617270;620501;654635;109636;112914;116908.83091169149;117197.4140129311;119688;1053.8682664666917;1065.504540388723;1066.3388699006666;1072.7157303314627;1077.9191560632828;15312.693746125238;18270.908645456686;18706.719399208752;18904.14931328066;19077.046147692836;37898.43152352662;49168;49583.00833983372;50137.74655633638;50358.49641503538;67503;71494.64252678704;71566.56866862738;79499.60250198712;81460.59269703613;6148;6696.598204107574;7759;8371.539565323723;8419.452735572168;8498.575071246536;9834.213262938805;11905.940470297593;12389.194702344319;12570.685732856751;11103.50034248477;11127.554897803997;11413.258138220988;11470.598529051444;11519.30884146954;10955.178361622751;11015.449227538751;11066.170037247399;11210.943945280547;11284;11429.314241145557;11449.42752862337;11786.46960886745;11842.467088980844;11886.583969561023;7208.855822883408;8228.547429891414;8450.299496132999;8579.742607721779;8581.65673373058;9836.754081148028;11288.548458061585;11480.311181329147;11647.534098636299;11659.125565582784 08:00:55 INFO - PROCESS | 1664 | |3;mootools.html;1458.431211827388;1622.726159964428;1648.554890179652;1942.426984039708;2040.2043203150765;8280.544570048645;8585.828283434343;8588.570571471433;8593.785155371119;8621.52581608013;8794.604242809073;8936.55317234139;9023.458592484456;9042.819143617124;9050.366474346798;2526.12848567244;2560.10396361273;2560.4239046214548;2563.717991020986;2564.576844820602;2509.623556466526;2530.6457096006575;2538.82228244023;2541.682289713786;2542.9745702543014;2506.1729629222405;2523.1925783749207;2570.2803215099802;2572.2283315005516;2579.8065145114097;2547.4777670577487;2551.5407226699185;2563.846169229843;2598.558245098338;2599.3891435512637;2560.797798490196;2580.780633646142;2590.53370393331;2595.429005618761;2607.9348016299746;9238.6304547818;9262.907370926272;9277.721668349961;9282.767930801716;9317.208037316836;4825.879353016167;5501.697406642633;5621.494065534122;5742.827715168552;5853.736581853785;3617.927641447183;3714.517112775322;3734.25314937011;3737.5328083989502;3748.7938163401004;1044.780596074825;1046.2414749306768;1070.855434516346;1098.8296813993843;1099.384344766933;12345.876541234653;12455.813162802566;12468.625941221868;12482.063845211645;12520.937395313056;4834.564889159992;4858.6356023298395;4947.925781113287;4963.652544321935;4977.203647416396;9886;10031.29780915329;10032.247581431422;10042.046005629454;10042.698719038295;5690.516306113944;5729.398413166641;5729.455701708331;5733.254676891977;5739.713014349266;4652.674312798139;4779.378680771478;5081.136206844845;5223.817166399233;5249.737513124329;4005.35914253718;4024.9798751006056;4071.97964010184;4105.44576482177;4162.771047592411;1258.628704532165;1262.9179103358251;1270.3457719274581;1276.4575055601333;1281.4938099450665;904.2675432899373;942.3179624370466;947.9810403791886;961.1349785193382;1001.6644424117857;6043.395660434009;6074.271087469444;6167.814965551041;6196.969015154986;6259.904516709648;454.05556442599976;456.17432447270545;457.81916143123277;461.3725333546374;479.3959610890303;3987.2623564640635;4022.0347116691783;4053.7365071270274;4088.3049881520215;4103.774292413946;11137.387443690675;11525.423728813526;11631.825522617168;11688.883111168949;11693.356865372316;11156.107511399068;11374.976252137347;11533.538658453735;11536.480858361227;11544.134189935621;7044.330788575179;8722.738317850475;8767.649294028168;8772.649094036167;8952.478078726503;6041.426064523863;6124.112003759341;6148.3236843948025;6220.595661282002;6233.376662333731;9514.524273786144;9827.066428689262;9884.406935583887;9894.703158905244;10129.088382045356;9903.009699030328;10175.847362289423;10215;10230.414285785417;10427.322224055411;7187.460940429384;7371.078615173104;7671.923280767121;7881.147930236275;8006.279434850891;7367.373773229336;8622.61198246093;8681.435706679045;8682.869756953525;8686.565671716262;7635.198304177981;7708.344790692854;7777.455578109704;7817.022872140982;7835.529868207926;7417.962910185631;7418.740344087931;7487;7580.658870350737;7597.924020759721;7150.678219480032;7259.9274007261365;7292.854142917005;7315.890261645973;7327.0841144856895;4946.82686105999;5074.898502030012;5087.87280317995;5148.301060650051;5185.896282074413;5091.847244582668;5153.871153221199;5175.844724658266;5178.546450052876;5228.451012643618 08:00:55 INFO - PROCESS | 1664 | |4;prototype.html;323.7345376791031;326.34079160096604;339.04896764575363;339.2401021711364;340.4705682663457;6469.5147863910215;6542.116814230078;6565.573237739543;6578;6581.144451221347;6165.969170154154;6357.23713154421;6389.380354054839;6523.706433210505;6538.150040494741;3958.9802050989847;4842.612590992712;4895.9510404895855;4907.362042934431;4945;4901;4901.215805471125;4905.901881962359;4908.558229759321;4909.410870695521;4561.270196768518;4651.1162879053045;4680.9297860532115;4698.130845793522;4854.320395144682;4643.628509719214;4782.0435912817575;4787.946651736613;4790.688605240648;4855.854324370239;4138.772367519785;4147.066909945268;4157.10622216222;4163.854265100707;4179.080602267496;6185.288691800411;6199.349068347804;6220.751169953196;6223.439890409885;6233.532485063638;4588.7246765194195;5688.232088668018;5711.05767548354;5713.14302854571;5714.399988001283;5919.5264378850015;6207.565470417073;6905.964105384182;6907;6917.51577389583;4507.211238033331;4535.954640453586;4543.909121817578;4545.545445455461;4558.703684260546;5905.852353691149;7208;7405.074365704287;7409.110906691178;7413.1474880388905;4599.7470139142;4625.653076019312;4630.305454181899;4644;4646.117237724821;4679.27471241958;4680.251159814414;4691.718496890129;4697.365855609517;4702.412198475191;5381.515663590296;5557.360903496069;5577.888442231133;5582.8325150245555;5614.606977511535;6961.338672826073;7017.157941047107;7022;7022;7039.964800175966;1597.2333280025653;1630.79615048119;1631.5350125214256;1632.6571420001694;1633.918304084791;975.5561219645044;989.6684610655511;1024.779672370444;1034.4982683398546;1053.984190237147;5188.481151884856;6386.648734319564;6425.518086143558;6788.422984046312;6832.316768323128;7355.5586664800285;7360.521566098187;7362.374198193106;7362.44781641379;7379.298966598165;6623.933760662332;6639.070530125786;6645.202575690948;6647.933520664828;6667.333266673294;3803.0682482791894;3862.748921320105;3865.5697391965155;3867.555231148454;3870.7096967727534;7345.15530713964;7639.732609358646;7661.693532258647;7676.731314403969;7681.500702454323;7494;7546.547207167588;7552;7553.282438168365;7556.65995030225;7636.312731854048;7641.732539361095;7645.273698998586;7661.118971318369;7664.31021208094;7008.719651213894;7222.34998850085;7259.709611615476;7268.854622907618;7280.3083707047745;5726.370099288992;7047.506674532939;7132.857342853217;7143.285671432815;7164.176119746296;7574.015378001045;7587.127480339832;7595.202503737249;7596.354309883501;7604.695812167452;4535.25168347219;4577.404937358122;4588.105319462807;4597.563231493003;4600.838970636011;6894.655267236518;7141.5359851231415;7153.570785752663;7156.141263048467;7157.64211789398;6913;6920.169579650475;6934.965325173342;6959.025736396808;6969.512134150561;6868.175818901564;6899.965500172467;6932.1578152957045;6937.167539895245;6948.444124470131;6792.320767923168;6793.72825086991;6804.11546498952;6806.9319306808275;6810.523263371517;5862.384449632727;6640.335966403321;6933.810447194347;6942.687579059056;6951;6567.310432404529;6579.967100164468;6722.226943901514;6801.931980680328;6823.931760682528 08:00:55 INFO - PROCESS | 1664 | |5;yui.html;685.9416949559287;719.7049209823973;723.1358526560758;725.1660590321131;752.7026824404358;15584.376624935003;15787.052776833398;15807.446739364124;15834.4457943972;15855.365785368585;11947.7610447791;14522.056066355679;14569.708605827904;14590.270486475687;14596.708065838704;764.7705688293518;774.0363247756551;926.4487629860222;928.1553786054709;939.9859002114973;947.8578213267996;949.6438835436711;954.4321128928276;955.0401846144615;956.5456408206081;1009.5709323537504;1011.0900189829139;1011.6459239266235;1012.3875055591371;1014.3305418423842;818.251300060444;829.3696790439279;829.5893532701351;830.1573902488979;1012.8936461671528;744.118219909409;760.741347941697;760.8136006678344;762.1616222155584;763.023330137425;15239.923800380928;15288.694226115414;15300.005499642488;15304.234788260654;15310.157941313224;12839.358032098358;12956.352182390843;12989.87010129896;13065.216087034712;13175.472981080746;10152.695419137437;10208.48957552127;10428;10546.314489558154;10762.515686794035;3547.255076433926;3567.126054116758;3613.295407395559;3653.2510835278704;3819.1788765415567;89123.55438222832;90701;90739.54630226806;90866.09133908643;90881;9798.265130115127;9980.500974951223;10206.693799186036;10214.438205898747;10225.028622281021;23785.167519136747;23911.760882390954;23935.92288346994;23960.7603923962;23971.04115835382;7530.962345188349;7724.150343462215;7744.4578879477895;7786.1435242123325;7863.370930325675;4125.938110928339;4149.502059752788;4283.635890949242;4329.047609525899;4332.415123958225;3823.617638236154;3885.514310711161;3887.028242939265;3889.416587511896;3899.805009749501;690.5166383531548;709.3899246647982;725.582789895812;740.7259314053726;741.088461192736;524.8766539863129;528.8149147798317;547.2038184441628;607.3410349770548;612.7242740766673;7858.214178582096;8422.705205317785;8536.573171341408;8568.871466928002;8591.785205369915;553.0680802847215;583.3583058635552;608.6287364707525;609.5641616244407;613.8066509049635;3743.2887751327708;3945.822437990297;4067.7559346439307;4112.753234805921;4223.352892371978;92779.53610231906;93207;93589.59615605771;94585;94888.52555737177;79380.20619793843;80255;80480.39039219182;80972.73677210962;82213.58893205615;70803;72866.63566682239;72919.27080729125;73159.26840731525;74289.62855185689;7791.688332466638;7917.010373703287;7963.442559020813;8040.798980025546;8046.316063134699;50795.492045079074;50939;51055.744721276154;51378.71553211199;51416.74291628518;55043;65008.02487962779;70657.64671176611;70954.6452267756;71543.28456715574;9955.253355998184;10284.794304114026;10323.587056517656;10345.37927724339;10497.370157790558;10641.8935810644;10925.726856828644;11048.281861678965;11101.833472497758;11366.886331136582;10573.471326433493;10634.468276585985;10739.979701928305;10784.568617255221;10929.78140437171;10555.788884222426;10721.624743133953;10812;10978.396188209725;11166.720831979266;8720.869186962327;10346.586136554755;10684.305520141166;10726.946365268124;10960.506777195205;8951.910480895107;9047.547622618975;9082.228010619172;9209.401388909699;9432.434053956784;8832.5583720815;9105;9138.908610914072;9197.172254497127;9257.074292570689 08:00:55 INFO - PROCESS | 1664 | __end_tp_report 08:00:55 INFO - PROCESS | 1664 | __start_cc_report 08:00:55 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1598 08:00:55 INFO - PROCESS | 1664 | __end_cc_report 08:00:55 INFO - PROCESS | 1664 | __startTimestamp1467039655913__endTimestamp 08:00:55 INFO - PROCESS | 1664 | 08:00:55 INFO - PROCESS | 1664 | ------- Summary: start ------- 08:00:55 INFO - PROCESS | 1664 | Number of tests: 6 08:00:55 INFO - PROCESS | 1664 | 08:00:55 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5959.37 Median:6212.13 stddev:628.67 (10.1%) stddev-sans-first:602.31 08:00:55 INFO - PROCESS | 1664 | Values: 3582.4 3645.7 3655.1 3655.4 3701.6 5954.6 6005.7 6036.1 6036.9 6049.5 6078.3 6085.1 6088.0 6092.2 6093.1 5333.1 5393.5 5425.5 5462.6 5514.3 5457.7 5487.3 5514.8 5520.2 5523.3 5430.7 5491.9 5502.5 5514.0 5521.7 5472.2 5487.4 5502.8 5518.8 5532.5 5325.6 5353.6 5362.0 5456.8 5482.8 5855.4 5926.5 5949.7 5960.6 5998.8 6306.0 6307.8 6347.1 6349.5 6371.0 6199.5 6295.4 6351.9 6357.9 6374.1 6135.4 6156.2 6200.3 6204.2 6218.8 6520.9 6542.2 6546.0 6551.5 6556.1 5235.2 6293.7 6339.8 6340.4 6381.9 6314.0 6334.7 6339.8 6347.4 6367.9 6294.5 6340.4 6360.8 6364.2 6395.7 6269.3 6294.1 6330.7 6332.0 6392.2 5079.5 5122.8 5129.3 5134.6 5141.3 4585.4 4622.9 4656.4 4657.9 4682.2 5104.5 6039.5 6098.6 6136.5 6144.3 6379.9 6383.7 6401.2 6411.6 6418.7 5936.1 6026.5 6088.5 6102.2 6105.9 5589.6 5599.9 5633.0 5645.3 5671.9 6612.4 6645.3 6661.3 6668.3 6670.5 6315.2 6327.0 6329.0 6374.0 6413.9 6614.8 6623.0 6629.8 6651.7 6652.7 6333.0 6345.3 6349.3 6350.7 6352.2 5347.8 6321.5 6334.3 6356.5 6378.6 6353.7 6355.0 6359.7 6365.8 6374.5 6225.2 6284.7 6358.2 6370.7 6404.1 6108.7 6133.5 6198.8 6236.1 6286.5 5258.5 6325.0 6329.1 6343.4 6348.3 6195.1 6212.1 6222.4 6327.8 6332.1 08:00:55 INFO - PROCESS | 1664 | 08:00:55 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:69638.58 Median:3591.67 stddev:151661.60 (4222.6%) stddev-sans-first:151998.31 08:00:55 INFO - PROCESS | 1664 | Values: 538.0 541.8 580.4 604.5 608.8 30663.7 32426.4 33033.0 40624.4 40640.8 35257.8 43751.0 43929.6 43995.3 44015.3 8997.1 9714.8 9938.1 9941.2 11759.9 11762.7 11888.7 11888.8 11898.7 11933.9 11864.3 11929.2 11932.0 11958.8 11971.9 11884.8 11887.7 11892.5 11896.5 11901.6 11716.2 12172.1 12201.0 12203.8 12206.5 42682.1 43187.0 43206.6 43214.8 43302.8 3318.5 3377.7 3499.3 3567.9 3722.4 29851.9 30051.2 31066.8 31270.7 31976.0 2783.5 2786.9 2793.6 2858.1 2901.4 408546.0 409080.0 409776.0 409832.0 411095.0 37729.6 64057.0 64854.0 65075.7 65199.7 37188.4 37265.4 37342.3 37385.8 37423.0 13322.5 16168.8 16190.9 16191.5 16217.5 13081.8 13955.4 13960.0 13985.7 14009.9 8352.4 8398.0 8432.4 8441.4 8520.6 3540.9 3583.9 3591.5 3591.8 3615.3 952.8 1032.5 1107.5 1120.5 1171.2 30839.7 30845.5 31048.7 31519.2 31660.4 1090.8 1190.0 1219.1 1258.0 1258.8 12980.4 15561.8 15781.5 16193.8 16246.0 654605.0 656850.0 665197.7 666234.0 668346.0 64296.7 64873.0 64953.0 65045.0 65152.0 1459.4 1512.7 1560.8 1571.7 1602.5 30485.8 32315.4 32925.7 33188.2 33472.5 58451.0 58967.4 59346.7 59471.7 59524.1 511182.0 616942.0 618215.0 618619.0 619639.0 45393.8 45900.5 47312.0 47330.3 47401.2 49039.0 49366.3 49419.9 50386.5 50568.0 39056.6 40155.8 40511.8 40600.0 41576.6 39503.4 39546.0 39719.0 40663.8 40665.4 39417.6 39740.4 39985.6 40166.4 40780.6 33741.5 34460.0 35390.8 35410.8 35557.1 21907.5 22020.7 26270.3 26718.3 28202.9 08:00:55 INFO - PROCESS | 1664 | 08:00:55 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:35094.52 Median:21439.86 stddev:102664.99 (478.9%) stddev-sans-first:102919.90 08:00:55 INFO - PROCESS | 1664 | Values: 373.8 419.3 420.4 421.4 434.5 14558.5 20778.5 21494.6 21546.9 21704.5 20491.6 20892.9 21342.8 21376.5 21385.1 5886.7 5903.1 6175.6 6179.2 6183.7 6076.6 6136.1 6137.2 6161.5 6163.0 4498.8 5755.3 6392.2 6704.9 6712.9 5492.3 6601.6 6662.0 6662.1 6676.0 5972.8 5990.8 5990.8 6016.5 6016.7 23169.7 24375.1 26096.3 26258.3 26516.3 2029.4 2219.6 2382.1 2789.9 2825.0 14941.6 14955.6 14957.3 15113.7 15356.6 1818.9 1826.8 1842.7 1879.7 1886.9 103969.4 105889.5 114536.0 115609.0 116649.0 11252.0 11413.3 11637.0 11764.2 11802.6 13081.6 13706.7 13978.0 14735.3 14817.5 7314.7 9054.0 9089.0 9138.5 9252.5 9262.0 9271.9 9282.5 9293.2 9326.5 6903.0 7038.2 7041.5 7053.2 7120.2 1977.8 1979.9 1983.6 1993.9 2040.0 1013.5 1035.3 1053.4 1097.8 1103.8 19611.8 21601.7 21609.7 21885.7 22044.9 1028.1 1064.6 1071.9 1073.6 1077.9 11231.2 11656.9 11717.9 11724.9 11764.6 588961.0 615153.0 617270.0 620501.0 654635.0 109636.0 112914.0 116908.8 117197.4 119688.0 1053.9 1065.5 1066.3 1072.7 1077.9 15312.7 18270.9 18706.7 18904.1 19077.0 37898.4 49168.0 49583.0 50137.7 50358.5 67503.0 71494.6 71566.6 79499.6 81460.6 6148.0 6696.6 7759.0 8371.5 8419.5 8498.6 9834.2 11905.9 12389.2 12570.7 11103.5 11127.6 11413.3 11470.6 11519.3 10955.2 11015.4 11066.2 11210.9 11284.0 11429.3 11449.4 11786.5 11842.5 11886.6 7208.9 8228.5 8450.3 8579.7 8581.7 9836.8 11288.5 11480.3 11647.5 11659.1 08:00:55 INFO - PROCESS | 1664 | 08:00:55 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5919.12 Median:4947.38 stddev:3324.22 (67.2%) stddev-sans-first:3316.64 08:00:55 INFO - PROCESS | 1664 | Values: 1458.4 1622.7 1648.6 1942.4 2040.2 8280.5 8585.8 8588.6 8593.8 8621.5 8794.6 8936.6 9023.5 9042.8 9050.4 2526.1 2560.1 2560.4 2563.7 2564.6 2509.6 2530.6 2538.8 2541.7 2543.0 2506.2 2523.2 2570.3 2572.2 2579.8 2547.5 2551.5 2563.8 2598.6 2599.4 2560.8 2580.8 2590.5 2595.4 2607.9 9238.6 9262.9 9277.7 9282.8 9317.2 4825.9 5501.7 5621.5 5742.8 5853.7 3617.9 3714.5 3734.3 3737.5 3748.8 1044.8 1046.2 1070.9 1098.8 1099.4 12345.9 12455.8 12468.6 12482.1 12520.9 4834.6 4858.6 4947.9 4963.7 4977.2 9886.0 10031.3 10032.2 10042.0 10042.7 5690.5 5729.4 5729.5 5733.3 5739.7 4652.7 4779.4 5081.1 5223.8 5249.7 4005.4 4025.0 4072.0 4105.4 4162.8 1258.6 1262.9 1270.3 1276.5 1281.5 904.3 942.3 948.0 961.1 1001.7 6043.4 6074.3 6167.8 6197.0 6259.9 454.1 456.2 457.8 461.4 479.4 3987.3 4022.0 4053.7 4088.3 4103.8 11137.4 11525.4 11631.8 11688.9 11693.4 11156.1 11375.0 11533.5 11536.5 11544.1 7044.3 8722.7 8767.6 8772.6 8952.5 6041.4 6124.1 6148.3 6220.6 6233.4 9514.5 9827.1 9884.4 9894.7 10129.1 9903.0 10175.8 10215.0 10230.4 10427.3 7187.5 7371.1 7671.9 7881.1 8006.3 7367.4 8622.6 8681.4 8682.9 8686.6 7635.2 7708.3 7777.5 7817.0 7835.5 7418.0 7418.7 7487.0 7580.7 7597.9 7150.7 7259.9 7292.9 7315.9 7327.1 4946.8 5074.9 5087.9 5148.3 5185.9 5091.8 5153.9 5175.8 5178.5 5228.5 08:00:55 INFO - PROCESS | 1664 | 08:00:55 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5700.64 Median:6530.93 stddev:1824.94 (27.9%) stddev-sans-first:1784.88 08:00:55 INFO - PROCESS | 1664 | Values: 323.7 326.3 339.0 339.2 340.5 6469.5 6542.1 6565.6 6578.0 6581.1 6166.0 6357.2 6389.4 6523.7 6538.2 3959.0 4842.6 4896.0 4907.4 4945.0 4901.0 4901.2 4905.9 4908.6 4909.4 4561.3 4651.1 4680.9 4698.1 4854.3 4643.6 4782.0 4787.9 4790.7 4855.9 4138.8 4147.1 4157.1 4163.9 4179.1 6185.3 6199.3 6220.8 6223.4 6233.5 4588.7 5688.2 5711.1 5713.1 5714.4 5919.5 6207.6 6906.0 6907.0 6917.5 4507.2 4536.0 4543.9 4545.5 4558.7 5905.9 7208.0 7405.1 7409.1 7413.1 4599.7 4625.7 4630.3 4644.0 4646.1 4679.3 4680.3 4691.7 4697.4 4702.4 5381.5 5557.4 5577.9 5582.8 5614.6 6961.3 7017.2 7022.0 7022.0 7040.0 1597.2 1630.8 1631.5 1632.7 1633.9 975.6 989.7 1024.8 1034.5 1054.0 5188.5 6386.6 6425.5 6788.4 6832.3 7355.6 7360.5 7362.4 7362.4 7379.3 6623.9 6639.1 6645.2 6647.9 6667.3 3803.1 3862.7 3865.6 3867.6 3870.7 7345.2 7639.7 7661.7 7676.7 7681.5 7494.0 7546.5 7552.0 7553.3 7556.7 7636.3 7641.7 7645.3 7661.1 7664.3 7008.7 7222.3 7259.7 7268.9 7280.3 5726.4 7047.5 7132.9 7143.3 7164.2 7574.0 7587.1 7595.2 7596.4 7604.7 4535.3 4577.4 4588.1 4597.6 4600.8 6894.7 7141.5 7153.6 7156.1 7157.6 6913.0 6920.2 6935.0 6959.0 6969.5 6868.2 6900.0 6932.2 6937.2 6948.4 6792.3 6793.7 6804.1 6806.9 6810.5 5862.4 6640.3 6933.8 6942.7 6951.0 6567.3 6580.0 6722.2 6801.9 6823.9 08:00:55 INFO - PROCESS | 1664 | 08:00:55 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:18787.68 Median:27798.03 stddev:26849.11 (96.6%) stddev-sans-first:26890.03 08:00:55 INFO - PROCESS | 1664 | Values: 685.9 719.7 723.1 725.2 752.7 15584.4 15787.1 15807.4 15834.4 15855.4 11947.8 14522.1 14569.7 14590.3 14596.7 764.8 774.0 926.4 928.2 940.0 947.9 949.6 954.4 955.0 956.5 1009.6 1011.1 1011.6 1012.4 1014.3 818.3 829.4 829.6 830.2 1012.9 744.1 760.7 760.8 762.2 763.0 15239.9 15288.7 15300.0 15304.2 15310.2 12839.4 12956.4 12989.9 13065.2 13175.5 10152.7 10208.5 10428.0 10546.3 10762.5 3547.3 3567.1 3613.3 3653.3 3819.2 89123.6 90701.0 90739.5 90866.1 90881.0 9798.3 9980.5 10206.7 10214.4 10225.0 23785.2 23911.8 23935.9 23960.8 23971.0 7531.0 7724.2 7744.5 7786.1 7863.4 4125.9 4149.5 4283.6 4329.0 4332.4 3823.6 3885.5 3887.0 3889.4 3899.8 690.5 709.4 725.6 740.7 741.1 524.9 528.8 547.2 607.3 612.7 7858.2 8422.7 8536.6 8568.9 8591.8 553.1 583.4 608.6 609.6 613.8 3743.3 3945.8 4067.8 4112.8 4223.4 92779.5 93207.0 93589.6 94585.0 94888.5 79380.2 80255.0 80480.4 80972.7 82213.6 70803.0 72866.6 72919.3 73159.3 74289.6 7791.7 7917.0 7963.4 8040.8 8046.3 50795.5 50939.0 51055.7 51378.7 51416.7 55043.0 65008.0 70657.6 70954.6 71543.3 9955.3 10284.8 10323.6 10345.4 10497.4 10641.9 10925.7 11048.3 11101.8 11366.9 10573.5 10634.5 10740.0 10784.6 10929.8 10555.8 10721.6 10812.0 10978.4 11166.7 8720.9 10346.6 10684.3 10726.9 10960.5 8951.9 9047.5 9082.2 9209.4 9432.4 8832.6 9105.0 9138.9 9197.2 9257.1 08:00:55 INFO - PROCESS | 1664 | -------- Summary: end -------- 08:00:55 INFO - PROCESS | 1664 | 08:00:56 INFO - TEST-INFO | 1664: exit 0 08:00:56 INFO - TEST-OK | dromaeo_css | took 1113163ms 08:00:56 INFO - TEST-START | kraken 08:00:56 INFO - operating with platform_type : mac_ 08:00:56 INFO - Initialising browser for kraken test... 08:00:56 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpKDsVDJ/profile http://localhost:49276/getInfo.html) 08:00:58 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 08:00:58 INFO - PROCESS | 1670 | colorDepth:24 08:00:58 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 08:00:58 INFO - PROCESS | 1670 | __metrics 08:00:58 INFO - PROCESS | 1670 | 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" 08:00:58 ERROR - PROCESS | 1670 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:00:59 INFO - TEST-INFO | 1670: exit 0 08:00:59 INFO - Browser initialized. 08:00:59 INFO - Running cycle 1/1 for kraken test... 08:00:59 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpKDsVDJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:11 INFO - PROCESS | 1673 | RSS: Main: 161751040 08:01:11 INFO - PROCESS | 1673 | 08:01:13 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 08:01:14 INFO - PROCESS | 1673 | RSS: Main: 224624640 08:01:14 INFO - PROCESS | 1673 | 08:01:17 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 08:01:17 INFO - PROCESS | 1673 | RSS: Main: 240295936 08:01:17 INFO - PROCESS | 1673 | 08:01:21 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 08:01:21 INFO - PROCESS | 1673 | RSS: Main: 325332992 08:01:21 INFO - PROCESS | 1673 | 08:01:23 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 08:01:24 INFO - PROCESS | 1673 | RSS: Main: 232124416 08:01:24 INFO - PROCESS | 1673 | 08:01:26 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:01:27 INFO - PROCESS | 1673 | RSS: Main: 232488960 08:01:27 INFO - PROCESS | 1673 | 08:01:29 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 08:01:30 INFO - PROCESS | 1673 | RSS: Main: 271314944 08:01:30 INFO - PROCESS | 1673 | 08:01:33 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 08:01:33 INFO - PROCESS | 1673 | RSS: Main: 271364096 08:01:33 INFO - PROCESS | 1673 | 08:01:36 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 08:01:37 INFO - PROCESS | 1673 | RSS: Main: 269860864 08:01:37 INFO - PROCESS | 1673 | 08:01:38 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:01:39 INFO - PROCESS | 1673 | RSS: Main: 261251072 08:01:39 INFO - PROCESS | 1673 | 08:01:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:01:41 INFO - PROCESS | 1673 | RSS: Main: 267661312 08:01:41 INFO - PROCESS | 1673 | 08:01:43 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:01:44 INFO - PROCESS | 1673 | RSS: Main: 271581184 08:01:44 INFO - PROCESS | 1673 | 08:01:47 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:01:47 INFO - PROCESS | 1673 | RSS: Main: 278769664 08:01:47 INFO - PROCESS | 1673 | 08:01:50 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:01:51 INFO - PROCESS | 1673 | RSS: Main: 275877888 08:01:51 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 08:01:53 INFO - PROCESS | 1673 | RSS: Main: 337145856 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | __start_tp_report 08:01:53 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 08:01:53 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 08:01:53 INFO - PROCESS | 1673 | |i|pagename|runs| 08:01:53 INFO - PROCESS | 1673 | |0;ai-astar;112;113;119;112;113;112;113;113;113;132 08:01:53 INFO - PROCESS | 1673 | |1;audio-beat-detection;156;119;143;160;118;136;119;151;156;115 08:01:53 INFO - PROCESS | 1673 | |2;audio-dft;185;187;187;197;261;209;186;183;186;182 08:01:53 INFO - PROCESS | 1673 | |3;audio-fft;70;80;72;153;55;55;58;67;144;81 08:01:53 INFO - PROCESS | 1673 | |4;audio-oscillator;92;90;140;79;79;80;119;78;76;122 08:01:53 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;90;88;90;88;90;87;91;87;90;87 08:01:53 INFO - PROCESS | 1673 | |6;imaging-darkroom;100;143;94;94;94;94;95;94;93;96 08:01:53 INFO - PROCESS | 1673 | |7;imaging-desaturate;85;86;83;84;85;85;81;84;84;86 08:01:53 INFO - PROCESS | 1673 | |8;json-parse-financial;60;65;61;63;61;64;65;77;58;56 08:01:53 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;59;63;61;74;71;76;66;64;64;65 08:01:53 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;80;80;79;80;85;98;102;100;100;81 08:01:53 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;127;126;123;127;123;125;125;125;143;136 08:01:53 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;164;165;141;216;210;170;161;155;202;161 08:01:53 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;65;68;70;66;69;65;67;68;66;65 08:01:53 INFO - PROCESS | 1673 | __end_tp_report 08:01:53 INFO - PROCESS | 1673 | __start_cc_report 08:01:53 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1869 08:01:53 INFO - PROCESS | 1673 | __end_cc_report 08:01:53 INFO - PROCESS | 1673 | __startTimestamp1467039713257__endTimestamp 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | ------- Summary: start ------- 08:01:53 INFO - PROCESS | 1673 | Number of tests: 14 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:115.20 Median:113.00 stddev:6.25 (5.5%) stddev-sans-first:6.52 08:01:53 INFO - PROCESS | 1673 | Values: 112.0 113.0 119.0 112.0 113.0 112.0 113.0 113.0 113.0 132.0 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:147.00 stddev:18.18 (12.4%) stddev-sans-first:17.98 08:01:53 INFO - PROCESS | 1673 | Values: 156.0 119.0 143.0 160.0 118.0 136.0 119.0 151.0 156.0 115.0 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:196.30 Median:187.00 stddev:24.13 (12.9%) stddev-sans-first:25.25 08:01:53 INFO - PROCESS | 1673 | Values: 185.0 187.0 187.0 197.0 261.0 209.0 186.0 183.0 186.0 182.0 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:83.50 Median:68.50 stddev:35.54 (51.9%) stddev-sans-first:37.36 08:01:53 INFO - PROCESS | 1673 | Values: 70.0 80.0 72.0 153.0 55.0 55.0 58.0 67.0 144.0 81.0 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:79.00 stddev:22.97 (29.1%) stddev-sans-first:24.33 08:01:53 INFO - PROCESS | 1673 | Values: 92.0 90.0 140.0 79.0 79.0 80.0 119.0 78.0 76.0 122.0 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:90.00 stddev:1.55 (1.7%) stddev-sans-first:1.58 08:01:53 INFO - PROCESS | 1673 | Values: 90.0 88.0 90.0 88.0 90.0 87.0 91.0 87.0 90.0 87.0 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:99.70 Median:94.00 stddev:15.34 (16.3%) stddev-sans-first:16.27 08:01:53 INFO - PROCESS | 1673 | Values: 100.0 143.0 94.0 94.0 94.0 94.0 95.0 94.0 93.0 96.0 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:85.00 stddev:1.49 (1.8%) stddev-sans-first:1.56 08:01:53 INFO - PROCESS | 1673 | Values: 85.0 86.0 83.0 84.0 85.0 85.0 81.0 84.0 84.0 86.0 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.50 stddev:5.73 (9.0%) stddev-sans-first:5.98 08:01:53 INFO - PROCESS | 1673 | Values: 60.0 65.0 61.0 63.0 61.0 64.0 65.0 77.0 58.0 56.0 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:65.50 stddev:5.58 (8.5%) stddev-sans-first:5.25 08:01:53 INFO - PROCESS | 1673 | Values: 59.0 63.0 61.0 74.0 71.0 76.0 66.0 64.0 64.0 65.0 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:80.00 stddev:10.07 (12.6%) stddev-sans-first:10.20 08:01:53 INFO - PROCESS | 1673 | Values: 80.0 80.0 79.0 80.0 85.0 98.0 102.0 100.0 100.0 81.0 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:126.50 stddev:6.43 (5.1%) stddev-sans-first:6.81 08:01:53 INFO - PROCESS | 1673 | Values: 127.0 126.0 123.0 127.0 123.0 125.0 125.0 125.0 143.0 136.0 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:167.50 stddev:25.44 (15.2%) stddev-sans-first:26.70 08:01:53 INFO - PROCESS | 1673 | Values: 164.0 165.0 141.0 216.0 210.0 170.0 161.0 155.0 202.0 161.0 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.79 (2.7%) stddev-sans-first:1.76 08:01:53 INFO - PROCESS | 1673 | Values: 65.0 68.0 70.0 66.0 69.0 65.0 67.0 68.0 66.0 65.0 08:01:53 INFO - PROCESS | 1673 | -------- Summary: end -------- 08:01:53 INFO - PROCESS | 1673 | 08:01:53 INFO - TEST-INFO | 1673: exit 0 08:01:54 INFO - TEST-OK | kraken | took 57435ms 08:01:54 INFO - SUITE-END | took 1170s 08:01:54 INFO - Completed test suite (00:19:31) 08:01:54 INFO - javascript benchmark 08:01:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3582.4089025310823, 3645.6901163401108, 3655.0862284428895, 3655.4151335786273, 3701.5743189533196, 5954.612950158236, 6005.669688167149, 6036.0644100164545, 6036.879262414744, 6049.485793707529, 6078.300995385532, 6085.087236914465, 6087.969560152204, 6092.208012958309, 6093.055576385667, 5333.093374126408, 5393.541548968343, 5425.538829199523, 5462.617616766828, 5514.283143191399, 5457.699826509541, 5487.314085739283, 5514.751836167362, 5520.171974203861, 5523.309586301712, 5430.67415955044, 5491.917621235684, 5502.532284755801, 5513.972430137844, 5521.723913804314, 5472.179173124024, 5487.368952570466, 5502.80740174096, 5518.834434966958, 5532.474414930575, 5325.573954083664, 5353.625246232766, 5362.034833729927, 5456.83629491112, 5482.835514934558, 5855.443732845373, 5926.525877929756, 5949.672767997802, 5960.582759206857, 5998.7600495980105, 6305.968470157666, 6307.842303942438, 6347.1114044033875, 6349.4602958748565, 6371.0, 6199.473044791153, 6295.401936815995, 6351.87296254077, 6357.936420635827, 6374.075759014917, 6135.355787642323, 6156.199694039791, 6200.348963358872, 6204.224471941007, 6218.751249950042, 6520.9347906520325, 6542.182227221598, 6545.967270163714, 6551.508636852255, 6556.082148499214, 5235.240890070919, 6293.685315734195, 6339.809805705836, 6340.365963403715, 6381.936180638227, 6314.0, 6334.651594162273, 6339.778107766206, 6347.39699728525, 6367.904481432783, 6294.527910406738, 6340.397662222082, 6360.809175724736, 6364.172657554488, 6395.680215989182, 6269.279032911182, 6294.118823364733, 6330.651814150174, 6332.0, 6392.232932048091, 5079.492050794891, 5122.769475373617, 5129.333186685707, 5134.589232861362, 5141.280220769096, 4585.403897493371, 4622.896582055157, 4656.4412270527755, 4657.906841863144, 4682.157211701926, 5104.464031276662, 6039.54703397247, 6098.573099883054, 6136.539759517965, 6144.262688477412, 6379.936200638027, 6383.680815959184, 6401.231852177769, 6411.551191416649, 6418.679066046679, 5936.109583562414, 6026.517878569792, 6088.452039316483, 6102.176206212193, 6105.908411373833, 5589.636673616202, 5599.8880022400135, 5633.0, 5645.266115404971, 5671.943280567141, 6612.426182817566, 6645.3022432643875, 6661.300563440769, 6668.266490685924, 6670.466362691071, 6315.242170939517, 6326.9683651581445, 6328.968355158195, 6374.0, 6413.935860641333, 6614.801555953329, 6622.966885165543, 6629.801105966829, 6651.667416629246, 6652.73389064432, 6332.968335158294, 6345.302016778243, 6349.333320001333, 6350.7142178603, 6352.205974253218, 5347.786088556414, 6321.52588555851, 6334.303226644974, 6356.5232607555545, 6378.649174295459, 6353.650549219838, 6355.0, 6359.7456101755415, 6365.840853978688, 6374.458171055512, 6225.221847269091, 6284.748610055546, 6358.1734374531015, 6370.74517019314, 6404.135441715309, 6108.72510737009, 6133.478654314434, 6198.783042593487, 6236.095766113797, 6286.465650419766, 5258.526732594085, 6324.968375158279, 6329.050642403677, 6343.429091381798, 6348.301686814539, 6195.132681424694, 6212.1303017578475, 6222.439980401786, 6327.778527751507, 6332.145160403286], "value": 5922.652325767001, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.0462019989976, 541.8293237630148, 580.3789944759108, 604.5012864386882, 608.846236382056, 30663.69336306639, 32426.351472970528, 33033.0, 40624.39063414051, 40640.78077657668, 35257.82371088141, 43751.0, 43929.56070439295, 43995.34006989898, 44015.339769903396, 8997.145271199226, 9714.805703885935, 9938.105570498654, 9941.204703623693, 11759.941200293986, 11762.705932351717, 11888.702782430466, 11888.821667674993, 11898.702532436715, 11933.940330298336, 11864.347460889647, 11929.22460040099, 11932.0, 11958.820617690742, 11971.880281197164, 11884.821727674092, 11887.702807429798, 11892.524299028028, 11896.524139034429, 11901.583444579399, 11716.23844450108, 12172.147949643528, 12201.023918086532, 12203.816942745865, 12206.511739530408, 42682.146357073, 43187.0, 43206.56793432057, 43214.78392608017, 43302.783486082684, 3318.4856347266214, 3377.746668999835, 3499.2826470573473, 3567.928641427183, 3722.3858063419502, 29851.85074074616, 30051.248718781986, 31066.844665776527, 31270.687293127234, 31976.0, 2783.5268004439295, 2786.874590643426, 2793.6368272124696, 2858.1282708773815, 2901.419716056776, 408546.0, 409079.9546002251, 409776.0, 409832.0, 411095.0, 37729.62270377261, 64057.03914441287, 64854.02718959219, 65075.698486030014, 65199.67400162969, 37188.442173367424, 37265.44101838474, 37342.25315493675, 37385.81307093447, 37423.0, 13322.467101316033, 16168.75746863798, 16190.947588406716, 16191.514254572146, 16217.51347459578, 13081.803772943413, 13955.372008259652, 13960.0, 13985.650358741113, 14009.85990140106, 8352.415330926899, 8398.0, 8432.367572432093, 8441.366897482714, 8520.61657225414, 3540.91147721309, 3583.94624080639, 3591.5331006968927, 3591.802450865175, 3615.331163734665, 952.8189643967625, 1032.4837581209395, 1107.4684151607112, 1120.5293776613678, 1171.1684703860185, 30839.69160308413, 30845.537316940263, 31048.73988231203, 31519.212019699233, 31660.366792664478, 1090.8200146975819, 1189.9881001190051, 1219.116140797932, 1257.955896605815, 1258.8426446694164, 12980.35098245084, 15561.766573501407, 15781.515687820192, 16193.757093643604, 16246.025238485729, 654605.0, 656850.0, 665197.6740116269, 666234.0, 668346.0, 64296.67851660712, 64873.0, 64953.0, 65045.02432463517, 65152.0, 1459.3724698379585, 1512.7201467728505, 1560.8127024757102, 1571.7406627906496, 1602.4791942618695, 30485.847570762893, 32315.35369292554, 32925.67074329226, 33188.1702957428, 33472.497912530845, 58451.0, 58967.41032589619, 59346.70326648339, 59471.70264148652, 59524.10713839209, 511182.0, 616942.0, 618215.0, 618619.0, 619639.0, 45393.77303113463, 45900.540994589624, 47312.0, 47330.29004564865, 47401.15593064289, 49039.0, 49366.25950610815, 49419.88427562643, 50386.49613503965, 50568.0, 39056.609433905294, 40155.799221003705, 40511.79744101378, 40600.0, 41576.58423415727, 39503.407448888865, 39546.011349716486, 39719.0, 40663.79668101641, 40665.39001914914, 39417.62038328645, 39740.40389394104, 39985.600143998185, 40166.39750403805, 40780.59219407768, 33741.493877592344, 34460.00329952193, 35390.82304588461, 35410.822945885106, 35557.1110722234, 21907.478605977925, 22020.669689954342, 26270.343241419116, 26718.332041699112, 28202.85898570494], "value": 20119.455033152113, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.81869793150315, 419.314420921793, 420.4009286766357, 421.39740171554683, 434.5415586556182, 14558.490452834152, 20778.480537986557, 21494.570108597818, 21546.89226553867, 21704.457388565294, 20491.590168196628, 20892.850893200906, 21342.786572134275, 21376.465588360297, 21385.144594216214, 5886.705664716768, 5903.144044113601, 6175.62946223228, 6179.165812615307, 6183.7217325220245, 6076.574639775217, 6136.140940268366, 6137.232845894263, 6161.537884658646, 6163.013917773157, 4498.775061246941, 5755.338136114337, 6392.16901802765, 6704.865902681943, 6712.899306510406, 5492.286002819648, 6601.585728444004, 6662.0, 6662.1339225900565, 6675.966620166892, 5972.820815375502, 5990.7903223386975, 5990.790322338741, 6016.458518733291, 6016.699165041774, 23169.652455213185, 24375.14686985947, 26096.34759131018, 26258.34354141143, 26516.337091572674, 2029.401326608654, 2219.6004719150546, 2382.0948039744785, 2789.860506974643, 2824.963164598045, 14941.626459338495, 14955.551333460013, 14957.252137393087, 15113.697726045417, 15356.616084597863, 1818.863585231113, 1826.7625208722914, 1842.6959551673958, 1879.7086451600023, 1886.9245230190777, 103969.44045839319, 105889.47055264752, 114536.0, 115609.0, 116649.0, 11252.0, 11413.315201087962, 11637.0, 11764.235324703866, 11802.645920622395, 13081.626429224985, 13706.725865482835, 13978.0, 14735.263236838115, 14817.481388151364, 7314.670839812221, 9054.0, 9089.0, 9138.54307284633, 9252.491112988715, 9261.953690231505, 9271.860922086174, 9282.48946307946, 9293.210077143518, 9326.487043212554, 6903.0, 7038.155421349471, 7041.507094503438, 7053.188883278489, 7120.181179164359, 1977.7725561560605, 1979.9307024254083, 1983.603279344137, 1993.8604297699312, 2039.9694004589944, 1013.5135135135176, 1035.2649618770756, 1053.4311471805293, 1097.8408130820985, 1103.7516558774373, 19611.803881961285, 21601.67597486039, 21609.67585486219, 21885.67171492429, 22044.88977555134, 1028.0695970147028, 1064.6060957445795, 1071.8552995345528, 1073.5521626737961, 1077.8814330423647, 11231.21381503287, 11656.94171529154, 11717.941410292893, 11724.88275117255, 11764.647060588197, 588961.0, 615153.0, 617270.0, 620501.0, 654635.0, 109636.0, 112914.0, 116908.83091169149, 117197.4140129311, 119688.0, 1053.8682664666917, 1065.504540388723, 1066.3388699006666, 1072.7157303314627, 1077.9191560632828, 15312.693746125238, 18270.908645456686, 18706.719399208752, 18904.14931328066, 19077.046147692836, 37898.43152352662, 49168.0, 49583.00833983372, 50137.74655633638, 50358.49641503538, 67503.0, 71494.64252678704, 71566.56866862738, 79499.60250198712, 81460.59269703613, 6148.0, 6696.598204107574, 7759.0, 8371.539565323723, 8419.452735572168, 8498.575071246536, 9834.213262938805, 11905.940470297593, 12389.194702344319, 12570.685732856751, 11103.50034248477, 11127.554897803997, 11413.258138220988, 11470.598529051444, 11519.30884146954, 10955.178361622751, 11015.449227538751, 11066.170037247399, 11210.943945280547, 11284.0, 11429.314241145557, 11449.42752862337, 11786.46960886745, 11842.467088980844, 11886.583969561023, 7208.855822883408, 8228.547429891414, 8450.299496132999, 8579.742607721779, 8581.65673373058, 9836.754081148028, 11288.548458061585, 11480.311181329147, 11647.534098636299, 11659.125565582784], "value": 9944.177941177306, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.431211827388, 1622.726159964428, 1648.554890179652, 1942.426984039708, 2040.2043203150765, 8280.544570048645, 8585.828283434343, 8588.570571471433, 8593.785155371119, 8621.52581608013, 8794.604242809073, 8936.55317234139, 9023.458592484456, 9042.819143617124, 9050.366474346798, 2526.12848567244, 2560.10396361273, 2560.4239046214548, 2563.717991020986, 2564.576844820602, 2509.623556466526, 2530.6457096006575, 2538.82228244023, 2541.682289713786, 2542.9745702543014, 2506.1729629222405, 2523.1925783749207, 2570.2803215099802, 2572.2283315005516, 2579.8065145114097, 2547.4777670577487, 2551.5407226699185, 2563.846169229843, 2598.558245098338, 2599.3891435512637, 2560.797798490196, 2580.780633646142, 2590.53370393331, 2595.429005618761, 2607.9348016299746, 9238.6304547818, 9262.907370926272, 9277.721668349961, 9282.767930801716, 9317.208037316836, 4825.879353016167, 5501.697406642633, 5621.494065534122, 5742.827715168552, 5853.736581853785, 3617.927641447183, 3714.517112775322, 3734.25314937011, 3737.5328083989502, 3748.7938163401004, 1044.780596074825, 1046.2414749306768, 1070.855434516346, 1098.8296813993843, 1099.384344766933, 12345.876541234653, 12455.813162802566, 12468.625941221868, 12482.063845211645, 12520.937395313056, 4834.564889159992, 4858.6356023298395, 4947.925781113287, 4963.652544321935, 4977.203647416396, 9886.0, 10031.29780915329, 10032.247581431422, 10042.046005629454, 10042.698719038295, 5690.516306113944, 5729.398413166641, 5729.455701708331, 5733.254676891977, 5739.713014349266, 4652.674312798139, 4779.378680771478, 5081.136206844845, 5223.817166399233, 5249.737513124329, 4005.35914253718, 4024.9798751006056, 4071.97964010184, 4105.44576482177, 4162.771047592411, 1258.628704532165, 1262.9179103358251, 1270.3457719274581, 1276.4575055601333, 1281.4938099450665, 904.2675432899373, 942.3179624370466, 947.9810403791886, 961.1349785193382, 1001.6644424117857, 6043.395660434009, 6074.271087469444, 6167.814965551041, 6196.969015154986, 6259.904516709648, 454.05556442599976, 456.17432447270545, 457.81916143123277, 461.3725333546374, 479.3959610890303, 3987.2623564640635, 4022.0347116691783, 4053.7365071270274, 4088.3049881520215, 4103.774292413946, 11137.387443690675, 11525.423728813526, 11631.825522617168, 11688.883111168949, 11693.356865372316, 11156.107511399068, 11374.976252137347, 11533.538658453735, 11536.480858361227, 11544.134189935621, 7044.330788575179, 8722.738317850475, 8767.649294028168, 8772.649094036167, 8952.478078726503, 6041.426064523863, 6124.112003759341, 6148.3236843948025, 6220.595661282002, 6233.376662333731, 9514.524273786144, 9827.066428689262, 9884.406935583887, 9894.703158905244, 10129.088382045356, 9903.009699030328, 10175.847362289423, 10215.0, 10230.414285785417, 10427.322224055411, 7187.460940429384, 7371.078615173104, 7671.923280767121, 7881.147930236275, 8006.279434850891, 7367.373773229336, 8622.61198246093, 8681.435706679045, 8682.869756953525, 8686.565671716262, 7635.198304177981, 7708.344790692854, 7777.455578109704, 7817.022872140982, 7835.529868207926, 7417.962910185631, 7418.740344087931, 7487.0, 7580.658870350737, 7597.924020759721, 7150.678219480032, 7259.9274007261365, 7292.854142917005, 7315.890261645973, 7327.0841144856895, 4946.82686105999, 5074.898502030012, 5087.87280317995, 5148.301060650051, 5185.896282074413, 5091.847244582668, 5153.871153221199, 5175.844724658266, 5178.546450052876, 5228.451012643618], "value": 4690.138495653515, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.7345376791031, 326.34079160096604, 339.04896764575363, 339.2401021711364, 340.4705682663457, 6469.5147863910215, 6542.116814230078, 6565.573237739543, 6578.0, 6581.144451221347, 6165.969170154154, 6357.23713154421, 6389.380354054839, 6523.706433210505, 6538.150040494741, 3958.9802050989847, 4842.612590992712, 4895.9510404895855, 4907.362042934431, 4945.0, 4901.0, 4901.215805471125, 4905.901881962359, 4908.558229759321, 4909.410870695521, 4561.270196768518, 4651.1162879053045, 4680.9297860532115, 4698.130845793522, 4854.320395144682, 4643.628509719214, 4782.0435912817575, 4787.946651736613, 4790.688605240648, 4855.854324370239, 4138.772367519785, 4147.066909945268, 4157.10622216222, 4163.854265100707, 4179.080602267496, 6185.288691800411, 6199.349068347804, 6220.751169953196, 6223.439890409885, 6233.532485063638, 4588.7246765194195, 5688.232088668018, 5711.05767548354, 5713.14302854571, 5714.399988001283, 5919.5264378850015, 6207.565470417073, 6905.964105384182, 6907.0, 6917.51577389583, 4507.211238033331, 4535.954640453586, 4543.909121817578, 4545.545445455461, 4558.703684260546, 5905.852353691149, 7208.0, 7405.074365704287, 7409.110906691178, 7413.1474880388905, 4599.7470139142, 4625.653076019312, 4630.305454181899, 4644.0, 4646.117237724821, 4679.27471241958, 4680.251159814414, 4691.718496890129, 4697.365855609517, 4702.412198475191, 5381.515663590296, 5557.360903496069, 5577.888442231133, 5582.8325150245555, 5614.606977511535, 6961.338672826073, 7017.157941047107, 7022.0, 7022.0, 7039.964800175966, 1597.2333280025653, 1630.79615048119, 1631.5350125214256, 1632.6571420001694, 1633.918304084791, 975.5561219645044, 989.6684610655511, 1024.779672370444, 1034.4982683398546, 1053.984190237147, 5188.481151884856, 6386.648734319564, 6425.518086143558, 6788.422984046312, 6832.316768323128, 7355.5586664800285, 7360.521566098187, 7362.374198193106, 7362.44781641379, 7379.298966598165, 6623.933760662332, 6639.070530125786, 6645.202575690948, 6647.933520664828, 6667.333266673294, 3803.0682482791894, 3862.748921320105, 3865.5697391965155, 3867.555231148454, 3870.7096967727534, 7345.15530713964, 7639.732609358646, 7661.693532258647, 7676.731314403969, 7681.500702454323, 7494.0, 7546.547207167588, 7552.0, 7553.282438168365, 7556.65995030225, 7636.312731854048, 7641.732539361095, 7645.273698998586, 7661.118971318369, 7664.31021208094, 7008.719651213894, 7222.34998850085, 7259.709611615476, 7268.854622907618, 7280.3083707047745, 5726.370099288992, 7047.506674532939, 7132.857342853217, 7143.285671432815, 7164.176119746296, 7574.015378001045, 7587.127480339832, 7595.202503737249, 7596.354309883501, 7604.695812167452, 4535.25168347219, 4577.404937358122, 4588.105319462807, 4597.563231493003, 4600.838970636011, 6894.655267236518, 7141.5359851231415, 7153.570785752663, 7156.141263048467, 7157.64211789398, 6913.0, 6920.169579650475, 6934.965325173342, 6959.025736396808, 6969.512134150561, 6868.175818901564, 6899.965500172467, 6932.1578152957045, 6937.167539895245, 6948.444124470131, 6792.320767923168, 6793.72825086991, 6804.11546498952, 6806.9319306808275, 6810.523263371517, 5862.384449632727, 6640.335966403321, 6933.810447194347, 6942.687579059056, 6951.0, 6567.310432404529, 6579.967100164468, 6722.226943901514, 6801.931980680328, 6823.931760682528], "value": 5091.611989881353, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.9416949559287, 719.7049209823973, 723.1358526560758, 725.1660590321131, 752.7026824404358, 15584.376624935003, 15787.052776833398, 15807.446739364124, 15834.4457943972, 15855.365785368585, 11947.7610447791, 14522.056066355679, 14569.708605827904, 14590.270486475687, 14596.708065838704, 764.7705688293518, 774.0363247756551, 926.4487629860222, 928.1553786054709, 939.9859002114973, 947.8578213267996, 949.6438835436711, 954.4321128928276, 955.0401846144615, 956.5456408206081, 1009.5709323537504, 1011.0900189829139, 1011.6459239266235, 1012.3875055591371, 1014.3305418423842, 818.251300060444, 829.3696790439279, 829.5893532701351, 830.1573902488979, 1012.8936461671528, 744.118219909409, 760.741347941697, 760.8136006678344, 762.1616222155584, 763.023330137425, 15239.923800380928, 15288.694226115414, 15300.005499642488, 15304.234788260654, 15310.157941313224, 12839.358032098358, 12956.352182390843, 12989.87010129896, 13065.216087034712, 13175.472981080746, 10152.695419137437, 10208.48957552127, 10428.0, 10546.314489558154, 10762.515686794035, 3547.255076433926, 3567.126054116758, 3613.295407395559, 3653.2510835278704, 3819.1788765415567, 89123.55438222832, 90701.0, 90739.54630226806, 90866.09133908643, 90881.0, 9798.265130115127, 9980.500974951223, 10206.693799186036, 10214.438205898747, 10225.028622281021, 23785.167519136747, 23911.760882390954, 23935.92288346994, 23960.7603923962, 23971.04115835382, 7530.962345188349, 7724.150343462215, 7744.4578879477895, 7786.1435242123325, 7863.370930325675, 4125.938110928339, 4149.502059752788, 4283.635890949242, 4329.047609525899, 4332.415123958225, 3823.617638236154, 3885.514310711161, 3887.028242939265, 3889.416587511896, 3899.805009749501, 690.5166383531548, 709.3899246647982, 725.582789895812, 740.7259314053726, 741.088461192736, 524.8766539863129, 528.8149147798317, 547.2038184441628, 607.3410349770548, 612.7242740766673, 7858.214178582096, 8422.705205317785, 8536.573171341408, 8568.871466928002, 8591.785205369915, 553.0680802847215, 583.3583058635552, 608.6287364707525, 609.5641616244407, 613.8066509049635, 3743.2887751327708, 3945.822437990297, 4067.7559346439307, 4112.753234805921, 4223.352892371978, 92779.53610231906, 93207.0, 93589.59615605771, 94585.0, 94888.52555737177, 79380.20619793843, 80255.0, 80480.39039219182, 80972.73677210962, 82213.58893205615, 70803.0, 72866.63566682239, 72919.27080729125, 73159.26840731525, 74289.62855185689, 7791.688332466638, 7917.010373703287, 7963.442559020813, 8040.798980025546, 8046.316063134699, 50795.492045079074, 50939.0, 51055.744721276154, 51378.71553211199, 51416.74291628518, 55043.0, 65008.02487962779, 70657.64671176611, 70954.6452267756, 71543.28456715574, 9955.253355998184, 10284.794304114026, 10323.587056517656, 10345.37927724339, 10497.370157790558, 10641.8935810644, 10925.726856828644, 11048.281861678965, 11101.833472497758, 11366.886331136582, 10573.471326433493, 10634.468276585985, 10739.979701928305, 10784.568617255221, 10929.78140437171, 10555.788884222426, 10721.624743133953, 10812.0, 10978.396188209725, 11166.720831979266, 8720.869186962327, 10346.586136554755, 10684.305520141166, 10726.946365268124, 10960.506777195205, 8951.910480895107, 9047.547622618975, 9082.228010619172, 9209.401388909699, 9432.434053956784, 8832.5583720815, 9105.0, 9138.908610914072, 9197.172254497127, 9257.074292570689], "value": 6991.581788005186, "unit": "score"}], "name": "dromaeo_css", "value": 7633.537262208784, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 119.0, 112.0, 113.0, 112.0, 113.0, 113.0, 113.0, 132.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 119.0, 143.0, 160.0, 118.0, 136.0, 119.0, 151.0, 156.0, 115.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 187.0, 197.0, 261.0, 209.0, 186.0, 183.0, 186.0, 182.0], "value": 196.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 80.0, 72.0, 153.0, 55.0, 55.0, 58.0, 67.0, 144.0, 81.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 140.0, 79.0, 79.0, 80.0, 119.0, 78.0, 76.0, 122.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 90.0, 88.0, 90.0, 87.0, 91.0, 87.0, 90.0, 87.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 143.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 93.0, 96.0], "value": 99.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 83.0, 84.0, 85.0, 85.0, 81.0, 84.0, 84.0, 86.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 65.0, 61.0, 63.0, 61.0, 64.0, 65.0, 77.0, 58.0, 56.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 61.0, 74.0, 71.0, 76.0, 66.0, 64.0, 64.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 80.0, 85.0, 98.0, 102.0, 100.0, 100.0, 81.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 123.0, 127.0, 123.0, 125.0, 125.0, 125.0, 143.0, 136.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 141.0, 216.0, 210.0, 170.0, 161.0, 155.0, 202.0, 161.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 70.0, 66.0, 69.0, 65.0, 67.0, 68.0, 66.0, 65.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1487.8, "alertThreshold": 2.0}]} 08:01:54 INFO - Return code: 0 08:01:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:01:54 ERROR - # TBPL SUCCESS # 08:01:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:01:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:01:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:01:54 INFO - 2016-06-27 08:01:54.571 screenresolution[1677:9871] starting screenresolution argv=screenresolution get 08:01:54 INFO - 2016-06-27 08:01:54.574 screenresolution[1677:9871] Display 0: 1600x1200x32@60 08:01:54 INFO - 2016-06-27 08:01:54.580 screenresolution[1678:9875] starting screenresolution argv=screenresolution list 08:01:54 INFO - Available Modes on Display 0 08:01:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:01:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:01:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:01:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:01:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:01:54 INFO - Intel Iris: 08:01:54 INFO - Chipset Model: Intel Iris 08:01:54 INFO - Type: GPU 08:01:54 INFO - Bus: Built-In 08:01:54 INFO - VRAM (Dynamic, Max): 1536 MB 08:01:54 INFO - Vendor: Intel (0x8086) 08:01:54 INFO - Device ID: 0x0a2e 08:01:54 INFO - Revision ID: 0x0009 08:01:54 INFO - Displays: 08:01:54 INFO - Display: 08:01:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:01:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:01:54 INFO - Display Serial Number: 1600x1200 60 08:01:54 INFO - Main Display: Yes 08:01:54 INFO - Mirror: Off 08:01:54 INFO - Online: Yes 08:01:54 INFO - Rotation: Supported 08:01:54 INFO - Return code: 0 08:01:54 INFO - Running post-action listener: _resource_record_post_action 08:01:54 INFO - Running post-run listener: _resource_record_post_run 08:01:55 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 38188544; Write bytes: 493257728; Read time: 391; Write time: 1599 08:01:55 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 194558464; Write bytes: 186955776; Read time: 17390; Write time: 399 08:01:55 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 31071744; Write bytes: 295513088; Read time: 305; Write time: 1166 08:01:55 INFO - Running post-run listener: _upload_blobber_files 08:01:55 INFO - Blob upload gear active. 08:01:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:01:55 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 08:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:01:56 INFO - (blobuploader) - INFO - Open directory for files ... 08:01:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:01:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:01:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:57 INFO - (blobuploader) - INFO - Done attempting. 08:01:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:01:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:01:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:58 INFO - (blobuploader) - INFO - Done attempting. 08:01:58 INFO - (blobuploader) - INFO - Iteration through files over. 08:01:58 INFO - Return code: 0 08:01:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:01:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:01:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/49c95696324bb69c03be33a8f83e41f7378aeed45c97b9dc5a308c650fcfb4bd20c500980fb704426faccf58b9484b6dae4482fe5d16a7b0f63ee0bd90cc0dff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee68a01d8ed51e30a3367d25b1380cd3f7ec04d43b82928b0229b7c8775bee261e1652915f8498941479a709ec0ef0c68019432479b83d70d115a43fc58e3c66"} 08:01:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:01:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:01:58 INFO - Contents: 08:01:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/49c95696324bb69c03be33a8f83e41f7378aeed45c97b9dc5a308c650fcfb4bd20c500980fb704426faccf58b9484b6dae4482fe5d16a7b0f63ee0bd90cc0dff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee68a01d8ed51e30a3367d25b1380cd3f7ec04d43b82928b0229b7c8775bee261e1652915f8498941479a709ec0ef0c68019432479b83d70d115a43fc58e3c66"} 08:01:58 INFO - Running post-run listener: copy_logs_to_upload_dir 08:01:58 INFO - Copying logs to upload dir... 08:01:58 INFO - mkdir: /builds/slave/test/build/upload/logs 08:01:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.673529 ========= master_lag: 0.35 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-06-27 08:01:58.521471) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:01:58.527447) ========= 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.NkM8VaUQgb/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.o3ZG99IL0c/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/49c95696324bb69c03be33a8f83e41f7378aeed45c97b9dc5a308c650fcfb4bd20c500980fb704426faccf58b9484b6dae4482fe5d16a7b0f63ee0bd90cc0dff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee68a01d8ed51e30a3367d25b1380cd3f7ec04d43b82928b0229b7c8775bee261e1652915f8498941479a709ec0ef0c68019432479b83d70d115a43fc58e3c66"} build_url:https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010929 build_url: 'https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/49c95696324bb69c03be33a8f83e41f7378aeed45c97b9dc5a308c650fcfb4bd20c500980fb704426faccf58b9484b6dae4482fe5d16a7b0f63ee0bd90cc0dff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee68a01d8ed51e30a3367d25b1380cd3f7ec04d43b82928b0229b7c8775bee261e1652915f8498941479a709ec0ef0c68019432479b83d70d115a43fc58e3c66"}' ========= master_lag: 0.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:01:58.666293) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:01:58.666611) ========= 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.NkM8VaUQgb/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.o3ZG99IL0c/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.005070 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:01:58.715623) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:01:58.715928) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:01:58.716243) ========= ========= Total master_lag: 0.59 =========