builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0170 starttime: 1467133334.1 results: success (0) buildid: 20160628075828 builduid: cc79df57ceac4240aee67e4232804bc3 revision: 39023f2bbf6e44d29165130cd5e19d35385f0b97 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:14.100614) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:14.101073) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:14.101356) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:14.144383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:14.144689) ========= 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.Mu5eepnw5g/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.XCdOJ9yfqQ/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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-28 10:02:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 184M=0s 2016-06-28 10:02:14 (184 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088896 ========= master_lag: 0.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:14.476786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:14.477163) ========= 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.Mu5eepnw5g/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.XCdOJ9yfqQ/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.029008 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:14.527817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 10:02:14.528159) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 39023f2bbf6e44d29165130cd5e19d35385f0b97 --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 39023f2bbf6e44d29165130cd5e19d35385f0b97 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Mu5eepnw5g/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.XCdOJ9yfqQ/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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-28 10:02:14,600 truncating revision to first 12 chars 2016-06-28 10:02:14,600 Setting DEBUG logging. 2016-06-28 10:02:14,600 attempt 1/10 2016-06-28 10:02:14,600 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/39023f2bbf6e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 10:02:15,619 unpacking tar archive at: mozilla-beta-39023f2bbf6e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.283966 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 10:02:15.833020) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:15.833342) ========= script_repo_revision: 39023f2bbf6e44d29165130cd5e19d35385f0b97 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:15.833730) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:15.833999) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:15.852200) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-28 10:02:15.852472) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Mu5eepnw5g/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.XCdOJ9yfqQ/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 10:02:16 INFO - MultiFileLogger online at 20160628 10:02:16 in /builds/slave/test 10:02:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:02:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:02:16 INFO - {'append_to_log': False, 10:02:16 INFO - 'base_work_dir': '/builds/slave/test', 10:02:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:02:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:02:16 INFO - 'branch': 'Mozilla-Beta', 10:02:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:02:16 INFO - 'config_files': ('talos/mac_config.py',), 10:02:16 INFO - 'default_actions': ('clobber', 10:02:16 INFO - 'read-buildbot-config', 10:02:16 INFO - 'download-and-extract', 10:02:16 INFO - 'populate-webroot', 10:02:16 INFO - 'create-virtualenv', 10:02:16 INFO - 'install', 10:02:16 INFO - 'run-tests'), 10:02:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:02:16 INFO - 'download_minidump_stackwalk': True, 10:02:16 INFO - 'download_symbols': 'ondemand', 10:02:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:02:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:02:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:02:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:02:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:02:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:02:16 INFO - 'installer_path': 'installer.exe', 10:02:16 INFO - 'log_level': 'info', 10:02:16 INFO - 'log_name': 'talos', 10:02:16 INFO - 'log_to_console': True, 10:02:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:02:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:02:16 INFO - 'opt_config_files': (), 10:02:16 INFO - 'pip_index': False, 10:02:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:02:16 INFO - 'cmd': ('bash', 10:02:16 INFO - '-c', 10:02:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:02:16 INFO - 'enabled': True, 10:02:16 INFO - 'halt_on_failure': False, 10:02:16 INFO - 'name': 'check_screen_resolution'},), 10:02:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:02:16 INFO - 'cmd': ('bash', 10:02:16 INFO - '-c', 10:02:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:02:16 INFO - 'enabled': True, 10:02:16 INFO - 'halt_on_failure': False, 10:02:16 INFO - 'name': 'check_screen_resolution'},), 10:02:16 INFO - 'run_cmd_checks_enabled': True, 10:02:16 INFO - 'sps_profile': False, 10:02:16 INFO - 'sps_profile_interval': 0, 10:02:16 INFO - 'suite': 'dromaeojs-e10s', 10:02:16 INFO - 'system_bits': '32', 10:02:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:02:16 INFO - 'title': 't-yosemite-r7-0170', 10:02:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:02:16 INFO - 'use_talos_json': True, 10:02:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:02:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:02:16 INFO - 'work_dir': 'build'} 10:02:16 INFO - ##### 10:02:16 INFO - ##### Running clobber step. 10:02:16 INFO - ##### 10:02:16 INFO - Running pre-action listener: _resource_record_pre_action 10:02:16 INFO - Running main action method: clobber 10:02:16 INFO - rmtree: /builds/slave/test/build 10:02:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:02:17 INFO - Running post-action listener: _resource_record_post_action 10:02:17 INFO - ##### 10:02:17 INFO - ##### Running read-buildbot-config step. 10:02:17 INFO - ##### 10:02:17 INFO - Running pre-action listener: _resource_record_pre_action 10:02:17 INFO - Running main action method: read_buildbot_config 10:02:17 INFO - Using buildbot properties: 10:02:17 INFO - { 10:02:17 INFO - "project": "", 10:02:17 INFO - "product": "firefox", 10:02:17 INFO - "script_repo_revision": "production", 10:02:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:02:17 INFO - "repository": "", 10:02:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:02:17 INFO - "buildid": "20160628075828", 10:02:17 INFO - "pgo_build": "False", 10:02:17 INFO - "basedir": "/builds/slave/test", 10:02:17 INFO - "buildnumber": 45, 10:02:17 INFO - "slavename": "t-yosemite-r7-0170", 10:02:17 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:02:17 INFO - "platform": "yosemite_r7", 10:02:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:02:17 INFO - "branch": "mozilla-beta", 10:02:17 INFO - "repo_path": "releases/mozilla-beta", 10:02:17 INFO - "revision": "39023f2bbf6e44d29165130cd5e19d35385f0b97", 10:02:17 INFO - "stage_platform": "macosx64", 10:02:17 INFO - "builduid": "cc79df57ceac4240aee67e4232804bc3", 10:02:17 INFO - "slavebuilddir": "test" 10:02:17 INFO - } 10:02:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 10:02:17 INFO - Running post-action listener: _resource_record_post_action 10:02:17 INFO - ##### 10:02:17 INFO - ##### Running download-and-extract step. 10:02:17 INFO - ##### 10:02:17 INFO - Running pre-action listener: _resource_record_pre_action 10:02:17 INFO - Running main action method: download_and_extract 10:02:17 INFO - mkdir: /builds/slave/test/build/tests 10:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:17 INFO - https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:02:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 10:02:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 10:02:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/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 10:02:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/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 10:02:19 INFO - Downloaded 1165 bytes. 10:02:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 10:02:19 INFO - Using the following test package requirements: 10:02:19 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 10:02:19 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:02:19 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 10:02:19 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:02:19 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 10:02:19 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:02:19 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:02:19 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 10:02:19 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 10:02:19 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:02:19 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 10:02:19 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:02:19 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 10:02:19 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:02:19 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 10:02:19 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:02:19 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 10:02:19 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 10:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:19 INFO - https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:02:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:02:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:02:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/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 10:02:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/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 10:02:21 INFO - Downloaded 18350398 bytes. 10:02:21 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'] 10:02:21 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 10:02:24 INFO - Return code: 0 10:02:24 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 10:02:24 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')]} 10:02:24 INFO - https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:02:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:02:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:02:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/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 10:02:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/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 10:02:25 INFO - Downloaded 18350398 bytes. 10:02:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:02:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:02:28 INFO - Return code: 0 10:02: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')]} 10:02:28 INFO - https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:02:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 10:02:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 10:02:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/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 10:02:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/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 10:02:31 INFO - Downloaded 10840145 bytes. 10:02:31 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'] 10:02:31 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 10:02:31 INFO - Return code: 0 10:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:31 INFO - https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 10:02:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:02:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:02:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 10:02:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/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 10:02:34 INFO - Downloaded 86200745 bytes. 10:02:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:02:34 INFO - mkdir: /builds/slave/test/properties 10:02:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:02:34 INFO - Writing to file /builds/slave/test/properties/build_url 10:02:34 INFO - Contents: 10:02:34 INFO - build_url:https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:02:35 INFO - Running post-action listener: _resource_record_post_action 10:02:35 INFO - Running post-action listener: set_extra_try_arguments 10:02:35 INFO - ##### 10:02:35 INFO - ##### Running populate-webroot step. 10:02:35 INFO - ##### 10:02:35 INFO - Running pre-action listener: _resource_record_pre_action 10:02:35 INFO - Running main action method: populate_webroot 10:02:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:02:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:02:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:02:35 INFO - '--tppagecycles', 10:02:35 INFO - '7'], 10:02:35 INFO - 'tests': ['tsvgm']}}, 10:02:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:02:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:02:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:02:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:02:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:35 INFO - 'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:35 INFO - 'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['damp', 'tps']}, 10:02:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:35 INFO - 'tests': ['damp', 'tps']}, 10:02:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['dromaeo_dom']}, 10:02:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:02:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['a11yr', 10:02:35 INFO - 'ts_paint', 10:02:35 INFO - 'tpaint', 10:02:35 INFO - 'sessionrestore', 10:02:35 INFO - 'sessionrestore_no_auto_restore', 10:02:35 INFO - 'tabpaint']}, 10:02:35 INFO - 'other-e10s': {'tests': ['a11yr', 10:02:35 INFO - 'ts_paint', 10:02:35 INFO - 'tpaint', 10:02:35 INFO - 'sessionrestore', 10:02:35 INFO - 'sessionrestore_no_auto_restore', 10:02:35 INFO - 'tabpaint']}, 10:02:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:02:35 INFO - 'ts_paint', 10:02:35 INFO - 'tpaint', 10:02:35 INFO - 'sessionrestore', 10:02:35 INFO - 'sessionrestore_no_auto_restore', 10:02:35 INFO - 'tabpaint']}, 10:02:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:02:35 INFO - 'ts_paint', 10:02:35 INFO - 'tpaint', 10:02:35 INFO - 'sessionrestore', 10:02:35 INFO - 'sessionrestore_no_auto_restore', 10:02:35 INFO - 'tabpaint']}, 10:02:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['a11yr', 10:02:35 INFO - 'ts_paint', 10:02:35 INFO - 'tpaint', 10:02:35 INFO - 'sessionrestore', 10:02:35 INFO - 'sessionrestore_no_auto_restore', 10:02:35 INFO - 'tabpaint']}, 10:02:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['a11yr', 10:02:35 INFO - 'ts_paint', 10:02:35 INFO - 'tpaint', 10:02:35 INFO - 'sessionrestore', 10:02:35 INFO - 'sessionrestore_no_auto_restore', 10:02:35 INFO - 'tabpaint']}, 10:02:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['tsvgx', 10:02:35 INFO - 'tsvgr_opacity', 10:02:35 INFO - 'tart', 10:02:35 INFO - 'tscrollx', 10:02:35 INFO - 'cart']}, 10:02:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:02:35 INFO - 'tsvgr_opacity', 10:02:35 INFO - 'tart', 10:02:35 INFO - 'tscrollx', 10:02:35 INFO - 'cart']}, 10:02:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:35 INFO - 'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['tp5o']}, 10:02:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:35 INFO - 'tests': ['tp5o']}, 10:02:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:35 INFO - 'talos_options': ['--disable-e10s', 10:02:35 INFO - '--xperf_path', 10:02:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:35 INFO - 'tests': ['tp5n']}, 10:02:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:02:35 INFO - 'talos_options': ['--xperf_path', 10:02:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:35 INFO - 'tests': ['tp5n']}}, 10:02:35 INFO - 'talos.zip': {'path': '', 10:02:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:02:35 INFO - Running post-action listener: _resource_record_post_action 10:02:35 INFO - ##### 10:02:35 INFO - ##### Running create-virtualenv step. 10:02:35 INFO - ##### 10:02:35 INFO - Running pre-action listener: _resource_record_pre_action 10:02:35 INFO - Running main action method: create_virtualenv 10:02:35 INFO - Creating virtualenv /builds/slave/test/build/venv 10:02:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:02:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:02:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:02:35 INFO - Using real prefix '/tools/python27' 10:02:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:02:36 INFO - Installing distribute.............................................................................................................................................................................................done. 10:02:39 INFO - Installing pip.................done. 10:02:39 INFO - Return code: 0 10:02:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10757da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7aad430a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10741ce00>, '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 0x107285db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107417b20>, '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.Mu5eepnw5g/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.XCdOJ9yfqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 10:02:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:02:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mu5eepnw5g/Render', 10:02:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:39 INFO - 'HOME': '/Users/cltbld', 10:02:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:39 INFO - 'LOGNAME': 'cltbld', 10:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:39 INFO - 'MOZ_NO_REMOTE': '1', 10:02:39 INFO - 'NO_EM_RESTART': '1', 10:02:39 INFO - 'PAGER': '/bin/cat', 10:02:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:39 INFO - 'PWD': '/builds/slave/test', 10:02:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:39 INFO - 'SHELL': '/bin/bash', 10:02:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCdOJ9yfqQ/Listeners', 10:02:39 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 10:02:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:39 INFO - 'USER': 'cltbld', 10:02:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:39 INFO - 'XPC_FLAGS': '0x0', 10:02:39 INFO - 'XPC_SERVICE_NAME': '0', 10:02:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:02:39 INFO - Cleaning up... 10:02:39 INFO - Return code: 0 10:02:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10757da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7aad430a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10741ce00>, '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 0x107285db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107417b20>, '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.Mu5eepnw5g/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.XCdOJ9yfqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 10:02:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:02:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mu5eepnw5g/Render', 10:02:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:39 INFO - 'HOME': '/Users/cltbld', 10:02:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:39 INFO - 'LOGNAME': 'cltbld', 10:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:39 INFO - 'MOZ_NO_REMOTE': '1', 10:02:39 INFO - 'NO_EM_RESTART': '1', 10:02:39 INFO - 'PAGER': '/bin/cat', 10:02:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:39 INFO - 'PWD': '/builds/slave/test', 10:02:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:39 INFO - 'SHELL': '/bin/bash', 10:02:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCdOJ9yfqQ/Listeners', 10:02:39 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 10:02:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:39 INFO - 'USER': 'cltbld', 10:02:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:39 INFO - 'XPC_FLAGS': '0x0', 10:02:39 INFO - 'XPC_SERVICE_NAME': '0', 10:02:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:39 INFO - Downloading/unpacking psutil>=0.7.1 10:02: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 10:02: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 10:02: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 10:02: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 10:02: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 10:02: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 10:02:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:02:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:42 INFO - Installing collected packages: psutil 10:02:42 INFO - Running setup.py install for psutil 10:02:42 INFO - building 'psutil._psutil_osx' extension 10:02:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:02:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:02:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:02:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:02:43 INFO - building 'psutil._psutil_posix' extension 10:02:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:02:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:02:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:02:43 INFO - ^ 10:02:43 INFO - 1 warning generated. 10:02:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:02:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:43 INFO - Successfully installed psutil 10:02:43 INFO - Cleaning up... 10:02:43 INFO - Return code: 0 10:02:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10757da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7aad430a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10741ce00>, '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 0x107285db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107417b20>, '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.Mu5eepnw5g/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.XCdOJ9yfqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 10:02:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:02:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:02:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mu5eepnw5g/Render', 10:02:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:43 INFO - 'HOME': '/Users/cltbld', 10:02:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:43 INFO - 'LOGNAME': 'cltbld', 10:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:43 INFO - 'MOZ_NO_REMOTE': '1', 10:02:43 INFO - 'NO_EM_RESTART': '1', 10:02:43 INFO - 'PAGER': '/bin/cat', 10:02:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:43 INFO - 'PWD': '/builds/slave/test', 10:02:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:43 INFO - 'SHELL': '/bin/bash', 10:02:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCdOJ9yfqQ/Listeners', 10:02:43 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 10:02:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:43 INFO - 'USER': 'cltbld', 10:02:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:43 INFO - 'XPC_FLAGS': '0x0', 10:02:43 INFO - 'XPC_SERVICE_NAME': '0', 10:02:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:02:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:02:46 INFO - Installing collected packages: mozsystemmonitor 10:02:46 INFO - Running setup.py install for mozsystemmonitor 10:02:46 INFO - Successfully installed mozsystemmonitor 10:02:46 INFO - Cleaning up... 10:02:46 INFO - Return code: 0 10:02:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10757da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7aad430a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10741ce00>, '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 0x107285db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107417b20>, '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.Mu5eepnw5g/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.XCdOJ9yfqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 10:02:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:02:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mu5eepnw5g/Render', 10:02:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:46 INFO - 'HOME': '/Users/cltbld', 10:02:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:46 INFO - 'LOGNAME': 'cltbld', 10:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:46 INFO - 'MOZ_NO_REMOTE': '1', 10:02:46 INFO - 'NO_EM_RESTART': '1', 10:02:46 INFO - 'PAGER': '/bin/cat', 10:02:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:46 INFO - 'PWD': '/builds/slave/test', 10:02:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:46 INFO - 'SHELL': '/bin/bash', 10:02:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCdOJ9yfqQ/Listeners', 10:02:46 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 10:02:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:46 INFO - 'USER': 'cltbld', 10:02:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:46 INFO - 'XPC_FLAGS': '0x0', 10:02:46 INFO - 'XPC_SERVICE_NAME': '0', 10:02:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:47 INFO - Downloading/unpacking blobuploader==1.2.4 10:02: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 10:02: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 10:02: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 10:02: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 10:02: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 10:02: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 10:02:49 INFO - Downloading blobuploader-1.2.4.tar.gz 10:02:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:02:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:02:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:50 INFO - Downloading docopt-0.6.1.tar.gz 10:02:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:02:50 INFO - Installing collected packages: blobuploader, requests, docopt 10:02:50 INFO - Running setup.py install for blobuploader 10:02:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:02:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:02:51 INFO - Running setup.py install for requests 10:02:51 INFO - Running setup.py install for docopt 10:02:51 INFO - Successfully installed blobuploader requests docopt 10:02:51 INFO - Cleaning up... 10:02:51 INFO - Return code: 0 10:02:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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')]} 10:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10757da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7aad430a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10741ce00>, '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 0x107285db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107417b20>, '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.Mu5eepnw5g/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.XCdOJ9yfqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 10:02:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:02:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mu5eepnw5g/Render', 10:02:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:51 INFO - 'HOME': '/Users/cltbld', 10:02:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:51 INFO - 'LOGNAME': 'cltbld', 10:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:51 INFO - 'MOZ_NO_REMOTE': '1', 10:02:51 INFO - 'NO_EM_RESTART': '1', 10:02:51 INFO - 'PAGER': '/bin/cat', 10:02:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:51 INFO - 'PWD': '/builds/slave/test', 10:02:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:51 INFO - 'SHELL': '/bin/bash', 10:02:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCdOJ9yfqQ/Listeners', 10:02:51 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 10:02:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:51 INFO - 'USER': 'cltbld', 10:02:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:51 INFO - 'XPC_FLAGS': '0x0', 10:02:51 INFO - 'XPC_SERVICE_NAME': '0', 10:02:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:52 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-MrEw39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:52 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-xQb5ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:52 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-jz2rDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:52 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-ZO2XS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:52 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-Szi8Ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:52 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-WbTZf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:52 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-ueD1Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:52 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-pKeqNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:52 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-ku0Glg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:52 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-_SnhJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:53 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-HpqFtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:53 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-hRJDh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:53 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-lbIJfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:53 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-7zWCy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:53 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-nz45fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:53 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-6dmMrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:53 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-E8clZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:02:53 INFO - Running setup.py install for manifestparser 10:02:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:02:53 INFO - Running setup.py install for mozcrash 10:02:54 INFO - Running setup.py install for mozdebug 10:02:54 INFO - Running setup.py install for mozdevice 10:02:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Running setup.py install for mozfile 10:02:54 INFO - Running setup.py install for mozhttpd 10:02:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Running setup.py install for mozinfo 10:02:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Running setup.py install for mozInstall 10:02:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Running setup.py install for mozleak 10:02:55 INFO - Running setup.py install for mozlog 10:02:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:02:55 INFO - Running setup.py install for moznetwork 10:02:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:02:55 INFO - Running setup.py install for mozprocess 10:02:55 INFO - Running setup.py install for mozprofile 10:02:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:02:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:02:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:02:55 INFO - Running setup.py install for mozrunner 10:02:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:02:55 INFO - Running setup.py install for mozscreenshot 10:02:56 INFO - Running setup.py install for moztest 10:02:56 INFO - Running setup.py install for mozversion 10:02:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:02:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:02:56 INFO - Cleaning up... 10:02:56 INFO - Return code: 0 10:02:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10757da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7aad430a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10741ce00>, '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 0x107285db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107417b20>, '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.Mu5eepnw5g/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.XCdOJ9yfqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 10:02:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:02:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mu5eepnw5g/Render', 10:02:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:56 INFO - 'HOME': '/Users/cltbld', 10:02:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:56 INFO - 'LOGNAME': 'cltbld', 10:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:56 INFO - 'MOZ_NO_REMOTE': '1', 10:02:56 INFO - 'NO_EM_RESTART': '1', 10:02:56 INFO - 'PAGER': '/bin/cat', 10:02:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:56 INFO - 'PWD': '/builds/slave/test', 10:02:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:56 INFO - 'SHELL': '/bin/bash', 10:02:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCdOJ9yfqQ/Listeners', 10:02:56 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 10:02:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:56 INFO - 'USER': 'cltbld', 10:02:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:56 INFO - 'XPC_FLAGS': '0x0', 10:02:56 INFO - 'XPC_SERVICE_NAME': '0', 10:02:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:56 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-Dk3CT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:56 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-Eq757N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:56 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-7rQK3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:56 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-mOVpA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:57 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)) 10:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:57 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-U2A4gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:57 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)) 10:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:57 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-OWxu9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:57 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)) 10:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:57 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-IHSlEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:57 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-pCN8zN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:57 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-EhFdCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:57 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-8ylxVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:57 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-5k6mfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:57 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-6UnhXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:57 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-aSupbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:58 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)) 10:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:58 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-2VtgWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:58 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)) 10:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:58 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-dx_nri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:58 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)) 10:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:58 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-cYBjwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:58 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)) 10:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:58 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-xrlGfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:02:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:02:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:02:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:02:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:02:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:02:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:02: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 10:02: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 10:02: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 10:02: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 10:02: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 10:02: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 10:03:00 INFO - Downloading blessings-1.6.tar.gz 10:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:03:00 INFO - Installing collected packages: blessings 10:03:00 INFO - Running setup.py install for blessings 10:03:01 INFO - Successfully installed blessings 10:03:01 INFO - Cleaning up... 10:03:01 INFO - Return code: 0 10:03:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:03:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:03:01 INFO - Reading from file tmpfile_stdout 10:03:01 INFO - Current package versions: 10:03:01 INFO - blessings == 1.6 10:03:01 INFO - blobuploader == 1.2.4 10:03:01 INFO - docopt == 0.6.1 10:03:01 INFO - manifestparser == 1.1 10:03:01 INFO - mozInstall == 1.12 10:03:01 INFO - mozcrash == 0.17 10:03:01 INFO - mozdebug == 0.1 10:03:01 INFO - mozdevice == 0.48 10:03:01 INFO - mozfile == 1.2 10:03:01 INFO - mozhttpd == 0.7 10:03:01 INFO - mozinfo == 0.9 10:03:01 INFO - mozleak == 0.1 10:03:01 INFO - mozlog == 3.1 10:03:01 INFO - moznetwork == 0.27 10:03:01 INFO - mozprocess == 0.22 10:03:01 INFO - mozprofile == 0.28 10:03:01 INFO - mozrunner == 6.11 10:03:01 INFO - mozscreenshot == 0.1 10:03:01 INFO - mozsystemmonitor == 0.0 10:03:01 INFO - moztest == 0.7 10:03:01 INFO - mozversion == 1.4 10:03:01 INFO - psutil == 3.1.1 10:03:01 INFO - requests == 1.2.3 10:03:01 INFO - wsgiref == 0.1.2 10:03:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10757da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7aad430a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10741ce00>, '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 0x107285db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107417b20>, '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.Mu5eepnw5g/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.XCdOJ9yfqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 10:03:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:03:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mu5eepnw5g/Render', 10:03:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:01 INFO - 'HOME': '/Users/cltbld', 10:03:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:01 INFO - 'LOGNAME': 'cltbld', 10:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:01 INFO - 'MOZ_NO_REMOTE': '1', 10:03:01 INFO - 'NO_EM_RESTART': '1', 10:03:01 INFO - 'PAGER': '/bin/cat', 10:03:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:01 INFO - 'PWD': '/builds/slave/test', 10:03:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:01 INFO - 'SHELL': '/bin/bash', 10:03:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCdOJ9yfqQ/Listeners', 10:03:01 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 10:03:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:01 INFO - 'USER': 'cltbld', 10:03:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:01 INFO - 'XPC_FLAGS': '0x0', 10:03:01 INFO - 'XPC_SERVICE_NAME': '0', 10:03:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:03:01 INFO - Cleaning up... 10:03:01 INFO - Return code: 0 10:03:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10757da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7aad430a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10741ce00>, '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 0x107285db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107417b20>, '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.Mu5eepnw5g/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.XCdOJ9yfqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 10:03:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:03:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mu5eepnw5g/Render', 10:03:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:01 INFO - 'HOME': '/Users/cltbld', 10:03:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:01 INFO - 'LOGNAME': 'cltbld', 10:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:01 INFO - 'MOZ_NO_REMOTE': '1', 10:03:01 INFO - 'NO_EM_RESTART': '1', 10:03:01 INFO - 'PAGER': '/bin/cat', 10:03:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:01 INFO - 'PWD': '/builds/slave/test', 10:03:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:01 INFO - 'SHELL': '/bin/bash', 10:03:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCdOJ9yfqQ/Listeners', 10:03:01 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 10:03:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:01 INFO - 'USER': 'cltbld', 10:03:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:01 INFO - 'XPC_FLAGS': '0x0', 10:03:01 INFO - 'XPC_SERVICE_NAME': '0', 10:03:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:01 INFO - Downloading/unpacking jsonschema 10:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:03:04 INFO - Downloading/unpacking functools32 (from jsonschema) 10:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:03:04 INFO - warning: no files found matching '*.txt' 10:03:04 INFO - no previously-included directories found matching 'build' 10:03:04 INFO - no previously-included directories found matching 'dist' 10:03:04 INFO - no previously-included directories found matching '.git*' 10:03:04 INFO - Installing collected packages: jsonschema, functools32 10:03:04 INFO - Running setup.py install for functools32 10:03:05 INFO - warning: no files found matching '*.txt' 10:03:05 INFO - no previously-included directories found matching 'build' 10:03:05 INFO - no previously-included directories found matching 'dist' 10:03:05 INFO - no previously-included directories found matching '.git*' 10:03:05 INFO - Successfully installed jsonschema functools32 10:03:05 INFO - Cleaning up... 10:03:05 INFO - Return code: 0 10:03:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:03:05 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')]} 10:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:05 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')]} 10:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:05 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 0x10757da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7aad430a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10741ce00>, '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 0x107285db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107417b20>, '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.Mu5eepnw5g/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.XCdOJ9yfqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 10:03:05 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 10:03:05 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 10:03:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mu5eepnw5g/Render', 10:03:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:05 INFO - 'HOME': '/Users/cltbld', 10:03:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:05 INFO - 'LOGNAME': 'cltbld', 10:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:05 INFO - 'MOZ_NO_REMOTE': '1', 10:03:05 INFO - 'NO_EM_RESTART': '1', 10:03:05 INFO - 'PAGER': '/bin/cat', 10:03:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:05 INFO - 'PWD': '/builds/slave/test', 10:03:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:05 INFO - 'SHELL': '/bin/bash', 10:03:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCdOJ9yfqQ/Listeners', 10:03:05 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 10:03:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:05 INFO - 'USER': 'cltbld', 10:03:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:05 INFO - 'XPC_FLAGS': '0x0', 10:03:05 INFO - 'XPC_SERVICE_NAME': '0', 10:03:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:05 INFO - Downloading/unpacking flake8 10:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:03:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:03:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:03:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:03:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:03:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:03:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:03:09 INFO - no previously-included directories found matching 'docs/_build' 10:03:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:03:09 INFO - Running setup.py install for pep8 10:03:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:03:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:03:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:03:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:03:09 INFO - no previously-included directories found matching 'docs/_build' 10:03:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:03:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:03:09 INFO - Cleaning up... 10:03:09 INFO - Return code: 0 10:03:09 INFO - Running post-action listener: _resource_record_post_action 10:03:09 INFO - Running post-action listener: _start_resource_monitoring 10:03:09 INFO - Starting resource monitoring. 10:03:09 INFO - ##### 10:03:09 INFO - ##### Running install step. 10:03:09 INFO - ##### 10:03:09 INFO - Running pre-action listener: _resource_record_pre_action 10:03:09 INFO - Running main action method: install 10:03:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:03:09 INFO - Reading from file tmpfile_stdout 10:03:09 INFO - Detecting whether we're running mozinstall >=1.0... 10:03:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:03:09 INFO - Reading from file tmpfile_stdout 10:03:09 INFO - Output received: 10:03:09 INFO - Usage: mozinstall [options] installer 10:03:09 INFO - Options: 10:03:09 INFO - -h, --help show this help message and exit 10:03:09 INFO - -d DEST, --destination=DEST 10:03:09 INFO - Directory to install application into. [default: 10:03:09 INFO - "/builds/slave/test"] 10:03:09 INFO - --app=APP Application being installed. [default: firefox] 10:03:09 INFO - mkdir: /builds/slave/test/build/application 10:03:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:03:31 INFO - Reading from file tmpfile_stdout 10:03:31 INFO - Output received: 10:03:31 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:03:31 INFO - Running post-action listener: _resource_record_post_action 10:03:31 INFO - ##### 10:03:31 INFO - ##### Running run-tests step. 10:03:31 INFO - ##### 10:03:31 INFO - Running pre-action listener: _resource_record_pre_action 10:03:31 INFO - Running main action method: run_tests 10:03:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:03:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:03:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:03:31 INFO - 2016-06-28 10:03:31.735 screenresolution[1647:8025] starting screenresolution argv=screenresolution get 10:03:31 INFO - 2016-06-28 10:03:31.737 screenresolution[1647:8025] Display 0: 1600x1200x32@60 10:03:31 INFO - 2016-06-28 10:03:31.743 screenresolution[1648:8027] starting screenresolution argv=screenresolution list 10:03:31 INFO - Available Modes on Display 0 10:03:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:03:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:03:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:03:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:03:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:03:31 INFO - Intel Iris: 10:03:31 INFO - Chipset Model: Intel Iris 10:03:31 INFO - Type: GPU 10:03:31 INFO - Bus: Built-In 10:03:31 INFO - VRAM (Dynamic, Max): 1536 MB 10:03:31 INFO - Vendor: Intel (0x8086) 10:03:31 INFO - Device ID: 0x0a2e 10:03:31 INFO - Revision ID: 0x0009 10:03:31 INFO - Displays: 10:03:31 INFO - Display: 10:03:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:03:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:03:31 INFO - Display Serial Number: 1600x1200 60 10:03:31 INFO - Main Display: Yes 10:03:31 INFO - Mirror: Off 10:03:31 INFO - Online: Yes 10:03:31 INFO - Rotation: Supported 10:03:31 INFO - Return code: 0 10:03:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:03:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:03:31 INFO - Python 2.7.3 10:03:31 INFO - Return code: 0 10:03:31 INFO - grabbing minidump binary from tooltool 10:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10741ce00>, '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 0x107285db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107417b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:03:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:03:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:03:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:03:32 INFO - Return code: 0 10:03:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:03:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:03:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:03:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:03:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:03:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:03:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:03:33 INFO - Return code: 0 10:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0170', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0170 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:03:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mu5eepnw5g/Render', 10:03:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:33 INFO - 'HOME': '/Users/cltbld', 10:03:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:33 INFO - 'LOGNAME': 'cltbld', 10:03:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:03:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:33 INFO - 'MOZ_NO_REMOTE': '1', 10:03:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:03:33 INFO - 'NO_EM_RESTART': '1', 10:03:33 INFO - 'PAGER': '/bin/cat', 10:03:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:33 INFO - 'PWD': '/builds/slave/test', 10:03:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:03:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:33 INFO - 'SHELL': '/bin/bash', 10:03:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XCdOJ9yfqQ/Listeners', 10:03:33 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 10:03:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:33 INFO - 'USER': 'cltbld', 10:03:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:33 INFO - 'XPC_FLAGS': '0x0', 10:03:33 INFO - 'XPC_SERVICE_NAME': '0', 10:03:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0170', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:03:33 INFO - mozversion application_buildid: 20160628075828 10:03:33 INFO - mozversion application_changeset: 39023f2bbf6e44d29165130cd5e19d35385f0b97 10:03:33 INFO - mozversion application_display_name: Firefox 10:03:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:03:33 INFO - mozversion application_name: Firefox 10:03:33 INFO - mozversion application_remotingname: firefox 10:03:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:03:33 INFO - mozversion application_vendor: Mozilla 10:03:33 INFO - mozversion application_version: 48.0 10:03:33 INFO - mozversion platform_buildid: 20160628075828 10:03:33 INFO - mozversion platform_changeset: 39023f2bbf6e44d29165130cd5e19d35385f0b97 10:03:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:03:33 INFO - mozversion platform_version: 48.0 10:03:33 INFO - using testdate: 1467133413 10:03:33 INFO - actual date: 1467133413 10:03:33 INFO - starting webserver on 'localhost:49286' 10:03:33 INFO - SUITE-START | Running 2 tests 10:03:33 INFO - TEST-START | dromaeo_css 10:03:33 INFO - operating with platform_type : mac_ 10:03:33 INFO - Initialising browser for dromaeo_css test... 10:03:33 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpPvyAHR/profile http://localhost:49286/getInfo.html) 10:03:36 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 10:03:36 INFO - PROCESS | 1666 | colorDepth:24 10:03:36 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 10:03:36 INFO - PROCESS | 1666 | __metrics 10:03:36 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:03:36 INFO - TEST-INFO | 1666: exit 0 10:03:36 INFO - Browser initialized. 10:03:36 INFO - Running cycle 1/1 for dromaeo_css test... 10:03:36 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpPvyAHR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:03:48 INFO - PROCESS | 1670 | RSS: Main: 171458560 10:03:48 INFO - PROCESS | 1670 | 10:04:38 INFO - PROCESS | 1670 | 1467133478361 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] 10:06:48 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49286/tests/dromaeo/cssquery-ext.html) 10:06:50 INFO - PROCESS | 1670 | RSS: Main: 182013952 10:06:50 INFO - PROCESS | 1670 | 10:09:52 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-ext.html (next: http://localhost:49286/tests/dromaeo/cssquery-jquery.html) 10:09:52 INFO - PROCESS | 1670 | RSS: Main: 192733184 10:09:52 INFO - PROCESS | 1670 | 10:12:54 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49286/tests/dromaeo/cssquery-mootools.html) 10:12:54 INFO - PROCESS | 1670 | RSS: Main: 194695168 10:12:54 INFO - PROCESS | 1670 | 10:15:56 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49286/tests/dromaeo/cssquery-prototype.html) 10:15:57 INFO - PROCESS | 1670 | RSS: Main: 198610944 10:15:57 INFO - PROCESS | 1670 | 10:18:59 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49286/tests/dromaeo/cssquery-yui.html) 10:19:00 INFO - PROCESS | 1670 | RSS: Main: 197689344 10:19:00 INFO - PROCESS | 1670 | 10:22:02 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-yui.html (next: http://localhost:49286/tests/dromaeo/cssquery-dojo.html) 10:22:02 INFO - PROCESS | 1670 | RSS: Main: 203239424 10:22:02 INFO - PROCESS | 1670 | 10:22:02 INFO - PROCESS | 1670 | __start_tp_report 10:22:02 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 10:22:02 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 10:22:02 INFO - PROCESS | 1670 | |i|pagename|runs| 10:22:02 INFO - PROCESS | 1670 | |0;dojo.html;3615.2950174715934;3692.0585250761087;3693.630636936307;3723.1809002019563;3746.9625303746952;4930.975345123278;5865.237519122508;6011.729472173752;6019.668918209497;6026.69866506674;5885.941140588593;5887.381824908387;5995.070764031571;6020.879582408349;6043.818685439433;5374.247605335247;5419.214213938976;5449.945500544984;5472.753726082316;5553.194786755918;5384.1923711443205;5461.1535212042;5462.235287059815;5518.834434966958;5565.721713914288;4052.9594704053025;4455.042165934324;5171.095058364771;5483.972580137094;5489.972550137264;5439.564834813225;5474.370447398541;5476.123820188751;5486.039943009957;5502.119660854284;5322.148456246982;5407.432219616923;5499.560035197174;5510.779568817243;5518.862028449281;6017.916774980502;6038;6047.0627052806885;6078.270607527125;6080.756769729205;6199.938000620026;6276.937230627681;6326.335734747831;6335.081413195061;6356.141920840673;6325.430711235965;6376.362363763633;6406.0390941359165;6406.359364063603;6421.903671444932;5161.406438259573;6134.141220229171;6153.907691384633;6154.5076393888385;6173.074038894112;6384.3934826191435;6469.320721324288;6520.15238019064;6537.673116344164;6557.540972131905;6270.153529273581;6276;6299.874002519924;6309.08518264849;6320.778772742932;6446.677666116675;6452.9677351612945;6456.451201647818;6461.741530338828;6461.903071453932;6187.474064704461;6226.875462490815;6257.217847769029;6296.087067375296;6302.779402720975;5609.831705048855;5860.3260625027815;6274.560780745304;6295.433410992941;6338.049292606053;5058.46886076964;5088.77100530477;5151.7681704323395;5158.252053452304;5164.586833053347;4579.198640237945;4592.563706447882;4604.424446944132;4642.442906851132;4692.95307046932;6114.694265286718;6146.784862529879;6180.289266734383;6181.505479561624;6192.071189321638;6300.590461620071;6485.837854053686;6505.772297969548;6515.837104072341;6518.902216466757;6041.456268935817;6092.3603021682975;6116.944513560587;6132.20254427538;6171.56799024064;5614.07367784311;5657.943420565742;5662.094064949588;5665.745041473144;5677.205191273225;6474.417302442803;6697.497687673346;6728.008028696535;6757.054012438262;6761.053452516651;6377.23473183221;6457.67711614408;6464.967675161594;6498.090267362479;6501.804945851632;6662.600243985376;6718.093057437183;6718.865622687616;6724.159480064992;6738.8652226956165;6213.65824879636;6285.937140628718;6287.559870809182;6357.205349331333;6360.681965901779;6416.165898433173;6424.068510066108;6465.676716164079;6472.93196622552;6487.448566871869;4510.66170037242;5726.370099288992;5895.496648354642;6291.370862913672;6310.148130002391;6196.535259855619;6197.349278325711;6250.3749625037135;6292.307846137013;6306.936930630635;5471.50756431923;6126.816195514141;6194.566380353332;6251.68741562911;6258.280297765815;5227.686338819683;6279.560430769985;6293.716782744879;6304.243490780952;6313.936860631335;6112.724927378367;6161.260648722182;6192.659403732838;6207.565470417027;6214.40963108504 10:22:02 INFO - PROCESS | 1670 | |1;ext.html;536.1957064403394;559.7509108446742;569.1548051144051;579.4061087385433;584.6917080085045;40620.796896015556;41461.75614731555;41495.58504414955;41608.58391416089;41617.16765664685;42715;42897.7855110724;43056.13887722244;43214.703558893205;43234.351484727755;8886.600102995348;9717.611295548188;9743.269254805882;9997.200223982063;10000.399976001427;9805.65680201193;9847.458389788559;10026.849597256047;10027.147692446151;10063;8239.588020598976;9914.504274786268;9985.950070249639;10000.000000000015;10052.09531142197;9894.158996485306;9936.95031524845;9965.750856228653;9992.25058120644;9993.250506212064;9854.655087071918;9971.501424928798;9972.700818975442;9985.051420115078;9985.600575976952;40822.79588602068;41153.382699259535;41420.37869431961;41868.371974420406;41972.160556789;3198.184462961953;3273.5908011498564;3355.094124586348;3357.9496307555405;3724.8696295629525;29471.410571788445;29727.70272297271;29984.700152998626;30003.849980750176;30349.69650303491;2624.409507860735;2628.250948479674;2646.7485588869026;2691.3137150026814;2708.5801700736415;436717;437820;438572.80713596544;438704;444305;38264.80867595644;67833;68238;68419.65790171117;69354.9596756049;37275.440868387;37994.62005379966;38233.23533529314;38347.80826095907;38421.423678644845;16492.42276520316;16806;16821.495355139366;16847.663046738995;16851.74722379165;14236.145831250158;14279.714405712035;14296.57110286693;14337.928310358382;14372.928135359465;8291.295239904675;8307.169283071644;8451.197136272045;8592.484450932963;8592.785180370542;2874.2957975296185;3117.610298712661;3168.2396224905856;3625.184333524936;3632.219072899339;1021.7139201023725;1074.1299547366657;1111.8109921313396;1178.5757127434117;1224.2226186371718;30819.229519262197;30943;31114.844425777726;31221.53167702486;31689.366212675617;1139.3733446604335;1145.3471521232984;1148.9310641361544;1186.5431808753692;1237.9195352302072;14023.228722420365;16114.838851611568;16190.676186476205;16290.83709162917;16621.252043658063;604882.9755851192;636001;648591;658117;671871;63214.68392658099;63688;64439.67780161069;64444.355556444774;64845.02732459017;1247.4635906560266;1462.778579885786;1525.7101150781539;1549.9690006200037;1552.7593223050446;30318.848405758712;30683.846580766953;30782.692173077983;31008.759649613763;31169.53245701271;55535.72232138814;55810.604734881956;56227.71886140543;56232;56253;582398;583409;585648;585966;588004;28159.43681126407;28633.856830716548;44639.77680111579;45711.314330284404;46676.299855501515;44365.33451998287;44613;44763.77618111888;44806;45024.77487612541;38061.61938380581;39063;39088.41367379435;39163;39284;38470.80764596159;38711;38836.94708588183;38990;39438.605613944645;37251.813740931124;38901;39850.800745996086;40435.1912961745;41450.585494144674;32388.570857185336;33698.66301336955;35316;36297;36823.63176368202;25881.48237035211;25972.74027259703;26161.607575885995;26243.475130497663;26483.940642374087 10:22:02 INFO - PROCESS | 1670 | |2;jquery.html;410.9075458021947;413.92549341118587;414.2026598797315;420.6235419299727;422.7801543197537;18396.72404913924;20545.58908821823;20601.484962875937;21204.89397553012;21530.784692153113;20860.687089693667;21154.25960091397;22436.887815560898;22479.21322753704;23069.769302306973;5739.339975902762;6125.387461253884;6251;6251.874962500748;6263.467605253536;6108.511319094462;6133.264008319008;6144.44699977002;6163.753449862;6205.317415084337;5970.940290597104;6044.7279872405625;6047.939520604804;6150.077488376757;6156.1996940397685;5862;6075.969620151893;6079.756809727605;6161.661108639023;6187.81436556904;5330.28041214435;5396.352437707461;5423.322084739408;5436.401995780461;5447.918281225785;26664;26800.59799103015;26931.86534067337;27156.728432715616;27249;2290.7709229077127;2393.988030059856;2414.348126005986;2464.346948058766;2480.4295012147127;15061.17163556004;15654.217289135611;15778.76331855023;16122.596935076717;16127.193640318055;1813.8276863697927;1814.845738112262;1826.2694922031294;1828.4423250908467;1839.062078340043;90384;95179.09641807195;108264.45867770689;112104;113099.86900130975;11355.886441135483;11473.71315717097;11495.252808567417;11892.286462812259;11910.52357905674;12488.063395245394;13489.325533723275;13897.79153312701;14405.78391324131;14863.851361486462;7693.769186924401;8035.674113771162;8641.697540586176;9140.131687489678;9353.766155846022;9572.76068098303;9601;9602.08780165883;9620.422774633544;9640.132388085107;6958.65206739661;7081.752138675225;7100.396466300423;7157.284271572905;7171.462140339496;1950.9317173898846;2000.3798822365113;2009.829164521003;2010.2160157538572;2029.594081183769;1023.1763430438568;1037.071820720451;1065.1585247654266;1099.142668718401;1148.5692865175558;21622.459438514165;22077.675339479683;22199.22302719397;22228.444288892584;22320.441988950406;1064.6167379743285;1070.6145787516489;1080.1574771677947;1087.983680244797;1165.947532361046;11828.645140645795;11926.821097683542;12129.393530323625;12153.69615759613;12189;648949;658330;660273;670810;672665;116753;119234.40382798204;120645;121621.78378216282;124024;1099.6151347028476;1105.7346236903086;1129.2321221569412;1137.3005601554985;1143.1997601678859;16619.252133654256;19115;19841.107150177988;19986.800131999076;20013.799862001193;44971.10057798891;52633;54761.09725685786;55093;55576;71020.64489677518;71547.28452715406;72131;72431;72673.90989135062;8286.502809831429;8329.791755206168;8330.625121869409;8440.113788052411;8658.740237792876;8870.51212183336;9011.639534418811;13266.933665331611;13270.33648317561;13572.321383930566;5413.621046526705;5988.401159884151;11355.829662554903;11487.081033517132;11674.533018679158;11216.66350009501;11408.657740267805;11516.136289778467;11551.88448115508;11987.160898737005;6565.868682626417;11666.475008624462;11873.990710789334;12001.63995080149;12084.45619947122;7091.219965803654;8284.337253019865;8330.50016998982;8395.70615028471;8614.3108551317;10929.331080409755;11793.29240245588;11844.940775296069;11980.28118312904;12000.819987700366 10:22:02 INFO - PROCESS | 1670 | |3;mootools.html;1614.2413065859048;1629.600747816785;1893.9905300473495;1988.2544045982756;2035.7557093148823;8285.254327110559;8855.690050848221;9061.275097992162;9300.906990930089;9319.021502742216;8893.155150260714;8941.463512189273;8984.236339911098;8997.235235005033;8998.68504602339;2534.075062602151;2574.8841302141354;2578.8323758955703;2580.9096681616147;2581.7805486533666;2484.6148846928754;2551.9489610207784;2555.923322300325;2555.9361015974655;2559.6800399950007;2549.6303036059853;2555.833870798392;2558.6289987951736;2597.7921766258746;2605.921822345323;2279.259240746764;2457.4225057111566;2554.9361265968314;2562.2569454858162;2587.3790290330376;2189.7810218977975;2587.0815860369485;2589.948201035969;2606.322356187386;2635.934101647455;7659.272369124924;8910.86633700495;9003.549822508914;9059.958104817899;9113.179813816789;5480.534154596864;5543.1408131739645;5550.361708403545;5614.2701448811395;5621.690807005613;3103.8137711737368;3261.2336101016244;3577.3560759063357;3654.2326111516613;3677.687396571295;1046.5238316565944;1066.2749330455288;1071.566015763617;1072.9570817167382;1073;11952.282863028158;12088.939555302255;12163.02695784335;12226.510939562408;12313.384330783514;4947.752612369367;5000.62495312853;5070.3155074064525;5073.985202959349;5084.872878178076;8598.78503037429;10415.479226038819;10578.471076446147;10595.84106238407;10609.628662996913;5514.172874068921;5553.028220061554;5559.221708960748;5623.6906970116215;5657.43425657431;4585.564371384713;4997.675151115166;5048.495150484996;5080.958403527268;5146.408163061221;4276.1661476012505;4284.1645879053285;4293.570642935744;4315.805788739514;4394.231009573376;1117.6591139702468;1379.655086228443;1418.758811002132;1422.5661173342023;1429.6497358147112;919.4850883505259;936.3492372800974;965.4786415335781;985.8126955878504;987.3730181334904;5836.328822185418;5873.970630146908;6040.546958978094;6062.878742425127;6146.385361463907;929.9442033478012;993.1359717046216;993.8062077894741;1032.4682788363998;1054.3726482742757;3998.140399814054;4020.336644453691;4071.572484889044;4105.096878686684;4120.17596480705;10730.463476826128;10965.725856853642;11069.391183484824;11095.889041109485;11174.776504470028;10728.088112510524;10738.73153171177;10792.136629069655;10801.243912926177;10840.457977101114;8601;8615.6984505542;8673.609687564074;8697.782555436164;8739.388242823068;6010.789622363196;6023.969880150571;6089.421504957022;6147.661878596541;6189.102580125947;9562.599962250513;9791.706248812547;9895.703128906145;10005;10162.695119146438;8598.82802343962;10217.489125543842;10249.692509224436;10278.434686092336;10322.793544129225;7759.7672069838;8292.83414331722;8400;8492.532910689724;8666.393352465268;8449.366297527833;8462.449940753831;8532.23209911086;8536.573171341532;8632.136786321318;7568.508046976929;7706.7687969361;7743.806404839924;7811.257930496594;7844.058712954482;7494.587797671181;7537.397008239437;7571.053618297713;7576.583287919218;7652.923470765221;7267.273272672691;7321.670524826289;7327.670254838438;7343.339099480859;7344.669489872862;4412.558744125562;4838.03239352138;4909.631777616622;5055.34280543527;5103.617228707788;5095.541401273755;5110.3356563646485;5149;5221.738913054408;5358.303420555459 10:22:02 INFO - PROCESS | 1670 | |4;prototype.html;334.64694747041864;334.95143204235404;335.9916002099948;341.51334348553314;347.0750450050615;5611.523020543259;6922.134733158356;6959.234484206733;6988.685509152087;7046.436285097187;6902.068220790192;6914.066601008863;6920.688569014394;6929.653517324139;6947.131608548932;4925.039617274624;4986.850394488171;5116.846494605168;5140.203268493389;5140.614453915952;5022.397312322508;5102.591792656597;5116.744162791864;5128.461511541291;5136.717480538568;4995.325631039799;5056.8482945511505;5077.238414237875;5079.1365467870555;5134.922976155361;4483;5123.462036486171;5125.256837758504;5130.948690513103;5138.203578445347;4386.956130438687;4387.62705170061;4391.01202229499;4395.494518130424;4400.713953593006;5401.378841433207;6468.611883287018;6713.664316784141;6747.932520674829;6748.8312792180095;5942.524598032147;5972.9701351493395;5995.340512543617;5995.640261584319;6001.189839371673;7455.5526668399525;7478.06524184477;7491.66287517063;7495.700171993114;7501.399888009001;4334.9783251083545;4502.819887204508;4783.4977327380475;4796.208625576775;4807.30294107356;7069.222385537587;7406.148292946326;7661.310482056641;7831.530108193527;7911.367090632735;4394.758288294174;4828.155072862235;4867.415910090741;4874.8787778810365;4879.072976134523;4671.649626277975;4951.851444456672;4968.577670897942;4970.478099799469;4971.632800979687;5170.741462926839;5722.685252311079;5964.433378829004;5966.940330596639;5970.313413957364;7509.474336796372;7517.849643007109;7549.131849837229;7557.244275572399;7570.735024274234;1649.6123410998405;1703.608170120879;1726.180064469367;1729.6454226883711;1730.5846596816925;1073.7423018475665;1082.767205050902;1090.2695194219891;1092.6885837536263;1094.5238821112682;6775.356341147583;6867.656617169122;6877.312268773083;6880.383109969153;6908.689108990107;7477.925220747723;7692.307692307607;7721.575313357819;7732.6133693315105;7735;7123.287671232835;7149.642517874189;7167.319104685047;7169.533980291264;7188.964055179691;4132.979335103305;4135.937960930589;4172.4784401949755;4176.1230141670585;4176.227397931392;8203.958980205061;8244.793880153044;8248.793780155544;8262.669493220325;8274.13121622221;7862.606869656494;8063.27430531255;8121.228483294078;8133.389995750343;8140.75577732669;6285.371462853769;7977.960110199412;8191.017077950565;8228.753137405887;8249.79375515617;7868.134505204537;7872.094709108297;7879.330256927996;7893.644785984529;7896.289333959971;7383.8154046149275;7701.268379503938;7720.189380115232;7739.18738532446;7739.806504837424;6787.115475922812;8368.41421100517;8428;8430.747077587683;8457.154284571494;4010.7994600269285;4864.586510146536;4866.853994380174;4867.787260408114;4886.975565122151;6757.297081167572;7855.567943763148;7880.2513761192595;7908.723194688158;7923.445358825057;6147.385261473817;7234.638268086469;7536;7562.016937798051;7580.583067931317;7493.4379921505015;7553.357964573072;7559.886601700869;7561.7731468056045;7592.734254301073;7332.706691732271;7355.889661654973;7365.558066516026;7376.631168441664;7405.407567394704;7538.283863033003;7567.281108294924;7572.7728168155045;7589.58257295854;7608.0489938757655;7002.544834585736;7278.526895751759;7305.634718263959;7309.853802924018;7394.038774959436 10:22:02 INFO - PROCESS | 1670 | |5;yui.html;686.8900975843866;742.7326162581471;766.4404984361416;776.5806464509162;787.5471603827797;15553.688926221483;15847.366105355772;15877;16163.676726465479;16189.595260118504;14769.261536923137;14858.628534286649;14861.405543778263;14888.925555372209;14893.478728244514;753.9736109236178;918.07733228106;928.5496534180951;953.0421925964396;954.2461455450186;940.2102234123334;945.4327403557879;952.4475804033644;952.8189643967659;955.9044095590455;973.5862258540128;975.6780262513389;1005.4570531912794;1007.4660429972126;1014.2849291249652;884.8585324930864;963.8650588917557;1008.2236677758159;1008.3042700536643;1012.6000229909218;734.5702763883135;735.7608777147449;740.6037769793189;760.6120878352081;768.2624680306913;15161.469348572857;15170.469033583771;15173.772393414107;15503.612409689847;15581.454649087342;12747.107702460831;12768.744625107445;13373.398197081155;13417.313462444477;13540.526081587195;9786.168175705074;9835.672184255105;10248;10426.402891002592;10461.267711260214;3596.5863925648623;3598.1904071583685;3648.233870887117;3695.8336874840697;3858.7298889077774;84028;84198;84314.57842710747;84484.57757711233;84945.57527212324;8698.913010869937;9652.662156824617;9752.512374381253;9771.267154963407;10050.396976181453;22825.885870570542;22841.543169136523;22935.54128917412;23327;23809.880950595136;7579.469437139458;7706.614669266626;7725.266099720518;7767.02912135983;7852.84294314122;4169.541350451448;4210.873673789792;4231.048014196843;4233.1322078973735;4233.259179643612;3771.4908487353855;3819.84720611178;3846.826892789831;3849.287881741831;3854.997700597865;610.1732152932801;652.797632733854;719.8596273726678;726.1934207271828;767.3017554025921;569.9259096317452;604.9637021778619;613.910982907476;617.6664601115438;625.4738438210751;8243.876341854877;8498.065212826585;8537.317014638815;8628.913710862937;8712.194781846563;517.4049842680872;554.6367129530164;618.0759764152621;624.9093881387173;638.409471239102;3526.9419174247623;3760.1163726524246;3998.5001874765653;4001.8199181036925;4018.7588744675413;89525;91951;97303.51348243355;99805;100088;58786.41213587809;75781;81099;81108.59445702734;83121.16878831256;65007.69984600281;65285.36786580373;68103.3189668107;71346.64326678333;73939.26060739432;8167.469114507538;8229.135940726137;8379.916200837913;8503.8724419135;8619.569021549023;51362.74318628383;51465;52639.21041184462;53204.46795531995;53240.73379633077;62204.688976554826;65802.67098664476;67096.32903670901;67259;68186;11154.776904461703;11264.662060137882;11370.658880233606;11509.07927365792;11743.823842642196;12021.158518903592;12209;12291.631251062483;12483;12505.874941250835;9660.516974151406;11781.469833857325;11812.62526049227;11906.76186476283;12045.735781814652;10985.90140985927;11507.42462876836;11722.23805452677;11842.11184161174;12017.077267637136;9451.763705907408;10201.948990255298;10417.801952775224;11740.41297935117;11862.169648124893;9243.260539156985;9853.396326711205;10004.099631033241;10115.241356898408;10213.693589192337;9982.101610855058;10096.293259471766;10126.696199114038;10205.234607404325;10211.029952154533 10:22:02 INFO - PROCESS | 1670 | __end_tp_report 10:22:02 INFO - PROCESS | 1670 | __start_cc_report 10:22:02 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,403 10:22:02 INFO - PROCESS | 1670 | __end_cc_report 10:22:02 INFO - PROCESS | 1670 | __startTimestamp1467134522906__endTimestamp 10:22:02 INFO - PROCESS | 1670 | 10:22:02 INFO - PROCESS | 1670 | ------- Summary: start ------- 10:22:02 INFO - PROCESS | 1670 | Number of tests: 6 10:22:02 INFO - PROCESS | 1670 | 10:22:02 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5926.06 Median:6180.29 stddev:666.03 (10.8%) stddev-sans-first:642.93 10:22:02 INFO - PROCESS | 1670 | Values: 3615.3 3692.1 3693.6 3723.2 3747.0 4931.0 5865.2 6011.7 6019.7 6026.7 5885.9 5887.4 5995.1 6020.9 6043.8 5374.2 5419.2 5449.9 5472.8 5553.2 5384.2 5461.2 5462.2 5518.8 5565.7 4053.0 4455.0 5171.1 5484.0 5490.0 5439.6 5474.4 5476.1 5486.0 5502.1 5322.1 5407.4 5499.6 5510.8 5518.9 6017.9 6038.0 6047.1 6078.3 6080.8 6199.9 6276.9 6326.3 6335.1 6356.1 6325.4 6376.4 6406.0 6406.4 6421.9 5161.4 6134.1 6153.9 6154.5 6173.1 6384.4 6469.3 6520.2 6537.7 6557.5 6270.2 6276.0 6299.9 6309.1 6320.8 6446.7 6453.0 6456.5 6461.7 6461.9 6187.5 6226.9 6257.2 6296.1 6302.8 5609.8 5860.3 6274.6 6295.4 6338.0 5058.5 5088.8 5151.8 5158.3 5164.6 4579.2 4592.6 4604.4 4642.4 4693.0 6114.7 6146.8 6180.3 6181.5 6192.1 6300.6 6485.8 6505.8 6515.8 6518.9 6041.5 6092.4 6116.9 6132.2 6171.6 5614.1 5657.9 5662.1 5665.7 5677.2 6474.4 6697.5 6728.0 6757.1 6761.1 6377.2 6457.7 6465.0 6498.1 6501.8 6662.6 6718.1 6718.9 6724.2 6738.9 6213.7 6285.9 6287.6 6357.2 6360.7 6416.2 6424.1 6465.7 6472.9 6487.4 4510.7 5726.4 5895.5 6291.4 6310.1 6196.5 6197.3 6250.4 6292.3 6306.9 5471.5 6126.8 6194.6 6251.7 6258.3 5227.7 6279.6 6293.7 6304.2 6313.9 6112.7 6161.3 6192.7 6207.6 6214.4 10:22:02 INFO - PROCESS | 1670 | 10:22:02 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:69072.93 Median:39026.50 stddev:150497.20 (385.6%) stddev-sans-first:150831.41 10:22:02 INFO - PROCESS | 1670 | Values: 536.2 559.8 569.2 579.4 584.7 40620.8 41461.8 41495.6 41608.6 41617.2 42715.0 42897.8 43056.1 43214.7 43234.4 8886.6 9717.6 9743.3 9997.2 10000.4 9805.7 9847.5 10026.8 10027.1 10063.0 8239.6 9914.5 9986.0 10000.0 10052.1 9894.2 9937.0 9965.8 9992.3 9993.3 9854.7 9971.5 9972.7 9985.1 9985.6 40822.8 41153.4 41420.4 41868.4 41972.2 3198.2 3273.6 3355.1 3357.9 3724.9 29471.4 29727.7 29984.7 30003.8 30349.7 2624.4 2628.3 2646.7 2691.3 2708.6 436717.0 437820.0 438572.8 438704.0 444305.0 38264.8 67833.0 68238.0 68419.7 69355.0 37275.4 37994.6 38233.2 38347.8 38421.4 16492.4 16806.0 16821.5 16847.7 16851.7 14236.1 14279.7 14296.6 14337.9 14372.9 8291.3 8307.2 8451.2 8592.5 8592.8 2874.3 3117.6 3168.2 3625.2 3632.2 1021.7 1074.1 1111.8 1178.6 1224.2 30819.2 30943.0 31114.8 31221.5 31689.4 1139.4 1145.3 1148.9 1186.5 1237.9 14023.2 16114.8 16190.7 16290.8 16621.3 604883.0 636001.0 648591.0 658117.0 671871.0 63214.7 63688.0 64439.7 64444.4 64845.0 1247.5 1462.8 1525.7 1550.0 1552.8 30318.8 30683.8 30782.7 31008.8 31169.5 55535.7 55810.6 56227.7 56232.0 56253.0 582398.0 583409.0 585648.0 585966.0 588004.0 28159.4 28633.9 44639.8 45711.3 46676.3 44365.3 44613.0 44763.8 44806.0 45024.8 38061.6 39063.0 39088.4 39163.0 39284.0 38470.8 38711.0 38836.9 38990.0 39438.6 37251.8 38901.0 39850.8 40435.2 41450.6 32388.6 33698.7 35316.0 36297.0 36823.6 25881.5 25972.7 26161.6 26243.5 26483.9 10:22:02 INFO - PROCESS | 1670 | 10:22:02 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:36426.98 Median:22458.05 stddev:109409.45 (487.2%) stddev-sans-first:109682.95 10:22:02 INFO - PROCESS | 1670 | Values: 410.9 413.9 414.2 420.6 422.8 18396.7 20545.6 20601.5 21204.9 21530.8 20860.7 21154.3 22436.9 22479.2 23069.8 5739.3 6125.4 6251.0 6251.9 6263.5 6108.5 6133.3 6144.4 6163.8 6205.3 5970.9 6044.7 6047.9 6150.1 6156.2 5862.0 6076.0 6079.8 6161.7 6187.8 5330.3 5396.4 5423.3 5436.4 5447.9 26664.0 26800.6 26931.9 27156.7 27249.0 2290.8 2394.0 2414.3 2464.3 2480.4 15061.2 15654.2 15778.8 16122.6 16127.2 1813.8 1814.8 1826.3 1828.4 1839.1 90384.0 95179.1 108264.5 112104.0 113099.9 11355.9 11473.7 11495.3 11892.3 11910.5 12488.1 13489.3 13897.8 14405.8 14863.9 7693.8 8035.7 8641.7 9140.1 9353.8 9572.8 9601.0 9602.1 9620.4 9640.1 6958.7 7081.8 7100.4 7157.3 7171.5 1950.9 2000.4 2009.8 2010.2 2029.6 1023.2 1037.1 1065.2 1099.1 1148.6 21622.5 22077.7 22199.2 22228.4 22320.4 1064.6 1070.6 1080.2 1088.0 1165.9 11828.6 11926.8 12129.4 12153.7 12189.0 648949.0 658330.0 660273.0 670810.0 672665.0 116753.0 119234.4 120645.0 121621.8 124024.0 1099.6 1105.7 1129.2 1137.3 1143.2 16619.3 19115.0 19841.1 19986.8 20013.8 44971.1 52633.0 54761.1 55093.0 55576.0 71020.6 71547.3 72131.0 72431.0 72673.9 8286.5 8329.8 8330.6 8440.1 8658.7 8870.5 9011.6 13266.9 13270.3 13572.3 5413.6 5988.4 11355.8 11487.1 11674.5 11216.7 11408.7 11516.1 11551.9 11987.2 6565.9 11666.5 11874.0 12001.6 12084.5 7091.2 8284.3 8330.5 8395.7 8614.3 10929.3 11793.3 11844.9 11980.3 12000.8 10:22:02 INFO - PROCESS | 1670 | 10:22:02 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5909.61 Median:5062.83 stddev:3247.12 (64.1%) stddev-sans-first:3240.19 10:22:02 INFO - PROCESS | 1670 | Values: 1614.2 1629.6 1894.0 1988.3 2035.8 8285.3 8855.7 9061.3 9300.9 9319.0 8893.2 8941.5 8984.2 8997.2 8998.7 2534.1 2574.9 2578.8 2580.9 2581.8 2484.6 2551.9 2555.9 2555.9 2559.7 2549.6 2555.8 2558.6 2597.8 2605.9 2279.3 2457.4 2554.9 2562.3 2587.4 2189.8 2587.1 2589.9 2606.3 2635.9 7659.3 8910.9 9003.5 9060.0 9113.2 5480.5 5543.1 5550.4 5614.3 5621.7 3103.8 3261.2 3577.4 3654.2 3677.7 1046.5 1066.3 1071.6 1073.0 1073.0 11952.3 12088.9 12163.0 12226.5 12313.4 4947.8 5000.6 5070.3 5074.0 5084.9 8598.8 10415.5 10578.5 10595.8 10609.6 5514.2 5553.0 5559.2 5623.7 5657.4 4585.6 4997.7 5048.5 5081.0 5146.4 4276.2 4284.2 4293.6 4315.8 4394.2 1117.7 1379.7 1418.8 1422.6 1429.6 919.5 936.3 965.5 985.8 987.4 5836.3 5874.0 6040.5 6062.9 6146.4 929.9 993.1 993.8 1032.5 1054.4 3998.1 4020.3 4071.6 4105.1 4120.2 10730.5 10965.7 11069.4 11095.9 11174.8 10728.1 10738.7 10792.1 10801.2 10840.5 8601.0 8615.7 8673.6 8697.8 8739.4 6010.8 6024.0 6089.4 6147.7 6189.1 9562.6 9791.7 9895.7 10005.0 10162.7 8598.8 10217.5 10249.7 10278.4 10322.8 7759.8 8292.8 8400.0 8492.5 8666.4 8449.4 8462.4 8532.2 8536.6 8632.1 7568.5 7706.8 7743.8 7811.3 7844.1 7494.6 7537.4 7571.1 7576.6 7652.9 7267.3 7321.7 7327.7 7343.3 7344.7 4412.6 4838.0 4909.6 5055.3 5103.6 5095.5 5110.3 5149.0 5221.7 5358.3 10:22:02 INFO - PROCESS | 1670 | 10:22:02 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:6093.82 Median:6911.38 stddev:1991.32 (28.8%) stddev-sans-first:1949.42 10:22:02 INFO - PROCESS | 1670 | Values: 334.6 335.0 336.0 341.5 347.1 5611.5 6922.1 6959.2 6988.7 7046.4 6902.1 6914.1 6920.7 6929.7 6947.1 4925.0 4986.9 5116.8 5140.2 5140.6 5022.4 5102.6 5116.7 5128.5 5136.7 4995.3 5056.8 5077.2 5079.1 5134.9 4483.0 5123.5 5125.3 5130.9 5138.2 4387.0 4387.6 4391.0 4395.5 4400.7 5401.4 6468.6 6713.7 6747.9 6748.8 5942.5 5973.0 5995.3 5995.6 6001.2 7455.6 7478.1 7491.7 7495.7 7501.4 4335.0 4502.8 4783.5 4796.2 4807.3 7069.2 7406.1 7661.3 7831.5 7911.4 4394.8 4828.2 4867.4 4874.9 4879.1 4671.6 4951.9 4968.6 4970.5 4971.6 5170.7 5722.7 5964.4 5966.9 5970.3 7509.5 7517.8 7549.1 7557.2 7570.7 1649.6 1703.6 1726.2 1729.6 1730.6 1073.7 1082.8 1090.3 1092.7 1094.5 6775.4 6867.7 6877.3 6880.4 6908.7 7477.9 7692.3 7721.6 7732.6 7735.0 7123.3 7149.6 7167.3 7169.5 7189.0 4133.0 4135.9 4172.5 4176.1 4176.2 8204.0 8244.8 8248.8 8262.7 8274.1 7862.6 8063.3 8121.2 8133.4 8140.8 6285.4 7978.0 8191.0 8228.8 8249.8 7868.1 7872.1 7879.3 7893.6 7896.3 7383.8 7701.3 7720.2 7739.2 7739.8 6787.1 8368.4 8428.0 8430.7 8457.2 4010.8 4864.6 4866.9 4867.8 4887.0 6757.3 7855.6 7880.3 7908.7 7923.4 6147.4 7234.6 7536.0 7562.0 7580.6 7493.4 7553.4 7559.9 7561.8 7592.7 7332.7 7355.9 7365.6 7376.6 7405.4 7538.3 7567.3 7572.8 7589.6 7608.0 7002.5 7278.5 7305.6 7309.9 7394.0 10:22:02 INFO - PROCESS | 1670 | 10:22:02 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:18623.08 Median:53222.60 stddev:26041.03 (48.9%) stddev-sans-first:26079.25 10:22:02 INFO - PROCESS | 1670 | Values: 686.9 742.7 766.4 776.6 787.5 15553.7 15847.4 15877.0 16163.7 16189.6 14769.3 14858.6 14861.4 14888.9 14893.5 754.0 918.1 928.5 953.0 954.2 940.2 945.4 952.4 952.8 955.9 973.6 975.7 1005.5 1007.5 1014.3 884.9 963.9 1008.2 1008.3 1012.6 734.6 735.8 740.6 760.6 768.3 15161.5 15170.5 15173.8 15503.6 15581.5 12747.1 12768.7 13373.4 13417.3 13540.5 9786.2 9835.7 10248.0 10426.4 10461.3 3596.6 3598.2 3648.2 3695.8 3858.7 84028.0 84198.0 84314.6 84484.6 84945.6 8698.9 9652.7 9752.5 9771.3 10050.4 22825.9 22841.5 22935.5 23327.0 23809.9 7579.5 7706.6 7725.3 7767.0 7852.8 4169.5 4210.9 4231.0 4233.1 4233.3 3771.5 3819.8 3846.8 3849.3 3855.0 610.2 652.8 719.9 726.2 767.3 569.9 605.0 613.9 617.7 625.5 8243.9 8498.1 8537.3 8628.9 8712.2 517.4 554.6 618.1 624.9 638.4 3526.9 3760.1 3998.5 4001.8 4018.8 89525.0 91951.0 97303.5 99805.0 100088.0 58786.4 75781.0 81099.0 81108.6 83121.2 65007.7 65285.4 68103.3 71346.6 73939.3 8167.5 8229.1 8379.9 8503.9 8619.6 51362.7 51465.0 52639.2 53204.5 53240.7 62204.7 65802.7 67096.3 67259.0 68186.0 11154.8 11264.7 11370.7 11509.1 11743.8 12021.2 12209.0 12291.6 12483.0 12505.9 9660.5 11781.5 11812.6 11906.8 12045.7 10985.9 11507.4 11722.2 11842.1 12017.1 9451.8 10201.9 10417.8 11740.4 11862.2 9243.3 9853.4 10004.1 10115.2 10213.7 9982.1 10096.3 10126.7 10205.2 10211.0 10:22:02 INFO - PROCESS | 1670 | -------- Summary: end -------- 10:22:02 INFO - PROCESS | 1670 | 10:22:03 INFO - TEST-INFO | 1670: exit 0 10:22:03 INFO - TEST-OK | dromaeo_css | took 1110008ms 10:22:03 INFO - TEST-START | kraken 10:22:03 INFO - operating with platform_type : mac_ 10:22:03 INFO - Initialising browser for kraken test... 10:22:03 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmp4PTQ7N/profile http://localhost:49286/getInfo.html) 10:22:05 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 10:22:05 INFO - PROCESS | 1679 | colorDepth:24 10:22:05 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 10:22:05 INFO - PROCESS | 1679 | __metrics 10:22:05 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:22:06 INFO - TEST-INFO | 1679: exit 0 10:22:06 INFO - Browser initialized. 10:22:06 INFO - Running cycle 1/1 for kraken test... 10:22:06 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmp4PTQ7N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:22:18 INFO - PROCESS | 1683 | RSS: Main: 171122688 10:22:18 INFO - PROCESS | 1683 | 10:22:21 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49286/tests/kraken/driver.html?testName=audio-beat-detection) 10:22:22 INFO - PROCESS | 1683 | RSS: Main: 183762944 10:22:22 INFO - PROCESS | 1683 | 10:22:24 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49286/tests/kraken/driver.html?testName=audio-dft) 10:22:25 INFO - PROCESS | 1683 | RSS: Main: 192331776 10:22:25 INFO - PROCESS | 1683 | 10:22:28 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49286/tests/kraken/driver.html?testName=audio-fft) 10:22:29 INFO - PROCESS | 1683 | RSS: Main: 196349952 10:22:29 INFO - PROCESS | 1683 | 10:22:31 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49286/tests/kraken/driver.html?testName=audio-oscillator) 10:22:31 INFO - PROCESS | 1683 | RSS: Main: 196743168 10:22:31 INFO - PROCESS | 1683 | 10:22:34 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49286/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:22:34 INFO - PROCESS | 1683 | RSS: Main: 197009408 10:22:34 INFO - PROCESS | 1683 | 10:22:37 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49286/tests/kraken/driver.html?testName=imaging-darkroom) 10:22:37 INFO - PROCESS | 1683 | RSS: Main: 197574656 10:22:37 INFO - PROCESS | 1683 | 10:22:40 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49286/tests/kraken/driver.html?testName=imaging-desaturate) 10:22:41 INFO - PROCESS | 1683 | RSS: Main: 197246976 10:22:41 INFO - PROCESS | 1683 | 10:22:44 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49286/tests/kraken/driver.html?testName=json-parse-financial) 10:22:44 INFO - PROCESS | 1683 | RSS: Main: 198529024 10:22:44 INFO - PROCESS | 1683 | 10:22:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49286/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:22:47 INFO - PROCESS | 1683 | RSS: Main: 198385664 10:22:47 INFO - PROCESS | 1683 | 10:22:49 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:22:49 INFO - PROCESS | 1683 | RSS: Main: 197746688 10:22:49 INFO - PROCESS | 1683 | 10:22:51 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:22:52 INFO - PROCESS | 1683 | RSS: Main: 197693440 10:22:52 INFO - PROCESS | 1683 | 10:22:55 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:22:55 INFO - PROCESS | 1683 | RSS: Main: 197877760 10:22:55 INFO - PROCESS | 1683 | 10:22:58 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:22:59 INFO - PROCESS | 1683 | RSS: Main: 197783552 10:22:59 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49286/tests/kraken/driver.html?testName=ai-astar) 10:23:01 INFO - PROCESS | 1683 | RSS: Main: 199794688 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | __start_tp_report 10:23:01 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 10:23:01 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 10:23:01 INFO - PROCESS | 1683 | |i|pagename|runs| 10:23:01 INFO - PROCESS | 1683 | |0;ai-astar;116;118;121;169;127;116;105;115;115;115 10:23:01 INFO - PROCESS | 1683 | |1;audio-beat-detection;152;122;147;160;118;141;144;189;153;152 10:23:01 INFO - PROCESS | 1683 | |2;audio-dft;200;201;197;209;195;196;199;195;196;197 10:23:01 INFO - PROCESS | 1683 | |3;audio-fft;61;107;104;172;57;56;55;67;128;57 10:23:01 INFO - PROCESS | 1683 | |4;audio-oscillator;78;82;130;77;80;84;122;80;79;124 10:23:01 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;91;88;90;88;91;88;91;89;97;88 10:23:01 INFO - PROCESS | 1683 | |6;imaging-darkroom;117;128;95;96;96;97;97;96;95;96 10:23:01 INFO - PROCESS | 1683 | |7;imaging-desaturate;92;91;89;91;90;91;90;113;146;114 10:23:01 INFO - PROCESS | 1683 | |8;json-parse-financial;59;63;63;63;66;64;73;106;94;85 10:23:01 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;64;68;64;70;75;76;68;65;65;67 10:23:01 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;79;82;79;80;82;80;80;106;107;83 10:23:01 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;143;155;149;147;144;146;133;148;168;153 10:23:01 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;164;162;166;163;170;210;160;165;160;161 10:23:01 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;66;69;66;67;67;69;67;68;73;68 10:23:01 INFO - PROCESS | 1683 | __end_tp_report 10:23:01 INFO - PROCESS | 1683 | __start_cc_report 10:23:01 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1036 10:23:01 INFO - PROCESS | 1683 | __end_cc_report 10:23:01 INFO - PROCESS | 1683 | __startTimestamp1467134581317__endTimestamp 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | ------- Summary: start ------- 10:23:01 INFO - PROCESS | 1683 | Number of tests: 14 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:121.70 Median:117.00 stddev:17.51 (15.0%) stddev-sans-first:18.45 10:23:01 INFO - PROCESS | 1683 | Values: 116.0 118.0 121.0 169.0 127.0 116.0 105.0 115.0 115.0 115.0 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:152.00 stddev:19.79 (13.0%) stddev-sans-first:20.93 10:23:01 INFO - PROCESS | 1683 | Values: 152.0 122.0 147.0 160.0 118.0 141.0 144.0 189.0 153.0 152.0 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:198.50 Median:198.00 stddev:4.22 (2.1%) stddev-sans-first:4.44 10:23:01 INFO - PROCESS | 1683 | Values: 200.0 201.0 197.0 209.0 195.0 196.0 199.0 195.0 196.0 197.0 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:86.40 Median:56.50 stddev:40.07 (70.9%) stddev-sans-first:41.44 10:23:01 INFO - PROCESS | 1683 | Values: 61.0 107.0 104.0 172.0 57.0 56.0 55.0 67.0 128.0 57.0 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:79.50 stddev:22.07 (27.8%) stddev-sans-first:22.68 10:23:01 INFO - PROCESS | 1683 | Values: 78.0 82.0 130.0 77.0 80.0 84.0 122.0 80.0 79.0 124.0 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:90.50 stddev:2.77 (3.1%) stddev-sans-first:2.92 10:23:01 INFO - PROCESS | 1683 | Values: 91.0 88.0 90.0 88.0 91.0 88.0 91.0 89.0 97.0 88.0 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:101.30 Median:96.00 stddev:11.49 (12.0%) stddev-sans-first:10.69 10:23:01 INFO - PROCESS | 1683 | Values: 117.0 128.0 95.0 96.0 96.0 97.0 97.0 96.0 95.0 96.0 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:100.70 Median:90.50 stddev:18.57 (20.5%) stddev-sans-first:19.43 10:23:01 INFO - PROCESS | 1683 | Values: 92.0 91.0 89.0 91.0 90.0 91.0 90.0 113.0 146.0 114.0 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:73.60 Median:65.00 stddev:15.97 (24.6%) stddev-sans-first:16.05 10:23:01 INFO - PROCESS | 1683 | Values: 59.0 63.0 63.0 63.0 66.0 64.0 73.0 106.0 94.0 85.0 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:4.32 (6.3%) stddev-sans-first:4.30 10:23:01 INFO - PROCESS | 1683 | Values: 64.0 68.0 64.0 70.0 75.0 76.0 68.0 65.0 65.0 67.0 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:80.00 stddev:10.99 (13.7%) stddev-sans-first:11.38 10:23:01 INFO - PROCESS | 1683 | Values: 79.0 82.0 79.0 80.0 82.0 80.0 80.0 106.0 107.0 83.0 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:148.60 Median:148.50 stddev:9.08 (6.1%) stddev-sans-first:9.40 10:23:01 INFO - PROCESS | 1683 | Values: 143.0 155.0 149.0 147.0 144.0 146.0 133.0 148.0 168.0 153.0 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:164.50 stddev:15.04 (9.1%) stddev-sans-first:15.88 10:23:01 INFO - PROCESS | 1683 | Values: 164.0 162.0 166.0 163.0 170.0 210.0 160.0 165.0 160.0 161.0 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:2.05 (3.0%) stddev-sans-first:2.05 10:23:01 INFO - PROCESS | 1683 | Values: 66.0 69.0 66.0 67.0 67.0 69.0 67.0 68.0 73.0 68.0 10:23:01 INFO - PROCESS | 1683 | -------- Summary: end -------- 10:23:01 INFO - PROCESS | 1683 | 10:23:01 INFO - TEST-INFO | 1683: exit 0 10:23:02 INFO - TEST-OK | kraken | took 58650ms 10:23:02 INFO - SUITE-END | took 1168s 10:23:02 INFO - Completed test suite (00:19:29) 10:23:02 INFO - javascript benchmark 10:23:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3615.2950174715934, 3692.0585250761087, 3693.630636936307, 3723.1809002019563, 3746.9625303746952, 4930.975345123278, 5865.237519122508, 6011.729472173752, 6019.668918209497, 6026.69866506674, 5885.941140588593, 5887.381824908387, 5995.070764031571, 6020.879582408349, 6043.818685439433, 5374.247605335247, 5419.214213938976, 5449.945500544984, 5472.753726082316, 5553.194786755918, 5384.1923711443205, 5461.1535212042, 5462.235287059815, 5518.834434966958, 5565.721713914288, 4052.9594704053025, 4455.042165934324, 5171.095058364771, 5483.972580137094, 5489.972550137264, 5439.564834813225, 5474.370447398541, 5476.123820188751, 5486.039943009957, 5502.119660854284, 5322.148456246982, 5407.432219616923, 5499.560035197174, 5510.779568817243, 5518.862028449281, 6017.916774980502, 6038.0, 6047.0627052806885, 6078.270607527125, 6080.756769729205, 6199.938000620026, 6276.937230627681, 6326.335734747831, 6335.081413195061, 6356.141920840673, 6325.430711235965, 6376.362363763633, 6406.0390941359165, 6406.359364063603, 6421.903671444932, 5161.406438259573, 6134.141220229171, 6153.907691384633, 6154.5076393888385, 6173.074038894112, 6384.3934826191435, 6469.320721324288, 6520.15238019064, 6537.673116344164, 6557.540972131905, 6270.153529273581, 6276.0, 6299.874002519924, 6309.08518264849, 6320.778772742932, 6446.677666116675, 6452.9677351612945, 6456.451201647818, 6461.741530338828, 6461.903071453932, 6187.474064704461, 6226.875462490815, 6257.217847769029, 6296.087067375296, 6302.779402720975, 5609.831705048855, 5860.3260625027815, 6274.560780745304, 6295.433410992941, 6338.049292606053, 5058.46886076964, 5088.77100530477, 5151.7681704323395, 5158.252053452304, 5164.586833053347, 4579.198640237945, 4592.563706447882, 4604.424446944132, 4642.442906851132, 4692.95307046932, 6114.694265286718, 6146.784862529879, 6180.289266734383, 6181.505479561624, 6192.071189321638, 6300.590461620071, 6485.837854053686, 6505.772297969548, 6515.837104072341, 6518.902216466757, 6041.456268935817, 6092.3603021682975, 6116.944513560587, 6132.20254427538, 6171.56799024064, 5614.07367784311, 5657.943420565742, 5662.094064949588, 5665.745041473144, 5677.205191273225, 6474.417302442803, 6697.497687673346, 6728.008028696535, 6757.054012438262, 6761.053452516651, 6377.23473183221, 6457.67711614408, 6464.967675161594, 6498.090267362479, 6501.804945851632, 6662.600243985376, 6718.093057437183, 6718.865622687616, 6724.159480064992, 6738.8652226956165, 6213.65824879636, 6285.937140628718, 6287.559870809182, 6357.205349331333, 6360.681965901779, 6416.165898433173, 6424.068510066108, 6465.676716164079, 6472.93196622552, 6487.448566871869, 4510.66170037242, 5726.370099288992, 5895.496648354642, 6291.370862913672, 6310.148130002391, 6196.535259855619, 6197.349278325711, 6250.3749625037135, 6292.307846137013, 6306.936930630635, 5471.50756431923, 6126.816195514141, 6194.566380353332, 6251.68741562911, 6258.280297765815, 5227.686338819683, 6279.560430769985, 6293.716782744879, 6304.243490780952, 6313.936860631335, 6112.724927378367, 6161.260648722182, 6192.659403732838, 6207.565470417027, 6214.40963108504], "value": 5887.571719958482, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.1957064403394, 559.7509108446742, 569.1548051144051, 579.4061087385433, 584.6917080085045, 40620.796896015556, 41461.75614731555, 41495.58504414955, 41608.58391416089, 41617.16765664685, 42715.0, 42897.7855110724, 43056.13887722244, 43214.703558893205, 43234.351484727755, 8886.600102995348, 9717.611295548188, 9743.269254805882, 9997.200223982063, 10000.399976001427, 9805.65680201193, 9847.458389788559, 10026.849597256047, 10027.147692446151, 10063.0, 8239.588020598976, 9914.504274786268, 9985.950070249639, 10000.000000000015, 10052.09531142197, 9894.158996485306, 9936.95031524845, 9965.750856228653, 9992.25058120644, 9993.250506212064, 9854.655087071918, 9971.501424928798, 9972.700818975442, 9985.051420115078, 9985.600575976952, 40822.79588602068, 41153.382699259535, 41420.37869431961, 41868.371974420406, 41972.160556789, 3198.184462961953, 3273.5908011498564, 3355.094124586348, 3357.9496307555405, 3724.8696295629525, 29471.410571788445, 29727.70272297271, 29984.700152998626, 30003.849980750176, 30349.69650303491, 2624.409507860735, 2628.250948479674, 2646.7485588869026, 2691.3137150026814, 2708.5801700736415, 436717.0, 437820.0, 438572.80713596544, 438704.0, 444305.0, 38264.80867595644, 67833.0, 68238.0, 68419.65790171117, 69354.9596756049, 37275.440868387, 37994.62005379966, 38233.23533529314, 38347.80826095907, 38421.423678644845, 16492.42276520316, 16806.0, 16821.495355139366, 16847.663046738995, 16851.74722379165, 14236.145831250158, 14279.714405712035, 14296.57110286693, 14337.928310358382, 14372.928135359465, 8291.295239904675, 8307.169283071644, 8451.197136272045, 8592.484450932963, 8592.785180370542, 2874.2957975296185, 3117.610298712661, 3168.2396224905856, 3625.184333524936, 3632.219072899339, 1021.7139201023725, 1074.1299547366657, 1111.8109921313396, 1178.5757127434117, 1224.2226186371718, 30819.229519262197, 30943.0, 31114.844425777726, 31221.53167702486, 31689.366212675617, 1139.3733446604335, 1145.3471521232984, 1148.9310641361544, 1186.5431808753692, 1237.9195352302072, 14023.228722420365, 16114.838851611568, 16190.676186476205, 16290.83709162917, 16621.252043658063, 604882.9755851192, 636001.0, 648591.0, 658117.0, 671871.0, 63214.68392658099, 63688.0, 64439.67780161069, 64444.355556444774, 64845.02732459017, 1247.4635906560266, 1462.778579885786, 1525.7101150781539, 1549.9690006200037, 1552.7593223050446, 30318.848405758712, 30683.846580766953, 30782.692173077983, 31008.759649613763, 31169.53245701271, 55535.72232138814, 55810.604734881956, 56227.71886140543, 56232.0, 56253.0, 582398.0, 583409.0, 585648.0, 585966.0, 588004.0, 28159.43681126407, 28633.856830716548, 44639.77680111579, 45711.314330284404, 46676.299855501515, 44365.33451998287, 44613.0, 44763.77618111888, 44806.0, 45024.77487612541, 38061.61938380581, 39063.0, 39088.41367379435, 39163.0, 39284.0, 38470.80764596159, 38711.0, 38836.94708588183, 38990.0, 39438.605613944645, 37251.813740931124, 38901.0, 39850.800745996086, 40435.1912961745, 41450.585494144674, 32388.570857185336, 33698.66301336955, 35316.0, 36297.0, 36823.63176368202, 25881.48237035211, 25972.74027259703, 26161.607575885995, 26243.475130497663, 26483.940642374087], "value": 19489.339631942676, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.9075458021947, 413.92549341118587, 414.2026598797315, 420.6235419299727, 422.7801543197537, 18396.72404913924, 20545.58908821823, 20601.484962875937, 21204.89397553012, 21530.784692153113, 20860.687089693667, 21154.25960091397, 22436.887815560898, 22479.21322753704, 23069.769302306973, 5739.339975902762, 6125.387461253884, 6251.0, 6251.874962500748, 6263.467605253536, 6108.511319094462, 6133.264008319008, 6144.44699977002, 6163.753449862, 6205.317415084337, 5970.940290597104, 6044.7279872405625, 6047.939520604804, 6150.077488376757, 6156.1996940397685, 5862.0, 6075.969620151893, 6079.756809727605, 6161.661108639023, 6187.81436556904, 5330.28041214435, 5396.352437707461, 5423.322084739408, 5436.401995780461, 5447.918281225785, 26664.0, 26800.59799103015, 26931.86534067337, 27156.728432715616, 27249.0, 2290.7709229077127, 2393.988030059856, 2414.348126005986, 2464.346948058766, 2480.4295012147127, 15061.17163556004, 15654.217289135611, 15778.76331855023, 16122.596935076717, 16127.193640318055, 1813.8276863697927, 1814.845738112262, 1826.2694922031294, 1828.4423250908467, 1839.062078340043, 90384.0, 95179.09641807195, 108264.45867770689, 112104.0, 113099.86900130975, 11355.886441135483, 11473.71315717097, 11495.252808567417, 11892.286462812259, 11910.52357905674, 12488.063395245394, 13489.325533723275, 13897.79153312701, 14405.78391324131, 14863.851361486462, 7693.769186924401, 8035.674113771162, 8641.697540586176, 9140.131687489678, 9353.766155846022, 9572.76068098303, 9601.0, 9602.08780165883, 9620.422774633544, 9640.132388085107, 6958.65206739661, 7081.752138675225, 7100.396466300423, 7157.284271572905, 7171.462140339496, 1950.9317173898846, 2000.3798822365113, 2009.829164521003, 2010.2160157538572, 2029.594081183769, 1023.1763430438568, 1037.071820720451, 1065.1585247654266, 1099.142668718401, 1148.5692865175558, 21622.459438514165, 22077.675339479683, 22199.22302719397, 22228.444288892584, 22320.441988950406, 1064.6167379743285, 1070.6145787516489, 1080.1574771677947, 1087.983680244797, 1165.947532361046, 11828.645140645795, 11926.821097683542, 12129.393530323625, 12153.69615759613, 12189.0, 648949.0, 658330.0, 660273.0, 670810.0, 672665.0, 116753.0, 119234.40382798204, 120645.0, 121621.78378216282, 124024.0, 1099.6151347028476, 1105.7346236903086, 1129.2321221569412, 1137.3005601554985, 1143.1997601678859, 16619.252133654256, 19115.0, 19841.107150177988, 19986.800131999076, 20013.799862001193, 44971.10057798891, 52633.0, 54761.09725685786, 55093.0, 55576.0, 71020.64489677518, 71547.28452715406, 72131.0, 72431.0, 72673.90989135062, 8286.502809831429, 8329.791755206168, 8330.625121869409, 8440.113788052411, 8658.740237792876, 8870.51212183336, 9011.639534418811, 13266.933665331611, 13270.33648317561, 13572.321383930566, 5413.621046526705, 5988.401159884151, 11355.829662554903, 11487.081033517132, 11674.533018679158, 11216.66350009501, 11408.657740267805, 11516.136289778467, 11551.88448115508, 11987.160898737005, 6565.868682626417, 11666.475008624462, 11873.990710789334, 12001.63995080149, 12084.45619947122, 7091.219965803654, 8284.337253019865, 8330.50016998982, 8395.70615028471, 8614.3108551317, 10929.331080409755, 11793.29240245588, 11844.940775296069, 11980.28118312904, 12000.819987700366], "value": 10030.593681182514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1614.2413065859048, 1629.600747816785, 1893.9905300473495, 1988.2544045982756, 2035.7557093148823, 8285.254327110559, 8855.690050848221, 9061.275097992162, 9300.906990930089, 9319.021502742216, 8893.155150260714, 8941.463512189273, 8984.236339911098, 8997.235235005033, 8998.68504602339, 2534.075062602151, 2574.8841302141354, 2578.8323758955703, 2580.9096681616147, 2581.7805486533666, 2484.6148846928754, 2551.9489610207784, 2555.923322300325, 2555.9361015974655, 2559.6800399950007, 2549.6303036059853, 2555.833870798392, 2558.6289987951736, 2597.7921766258746, 2605.921822345323, 2279.259240746764, 2457.4225057111566, 2554.9361265968314, 2562.2569454858162, 2587.3790290330376, 2189.7810218977975, 2587.0815860369485, 2589.948201035969, 2606.322356187386, 2635.934101647455, 7659.272369124924, 8910.86633700495, 9003.549822508914, 9059.958104817899, 9113.179813816789, 5480.534154596864, 5543.1408131739645, 5550.361708403545, 5614.2701448811395, 5621.690807005613, 3103.8137711737368, 3261.2336101016244, 3577.3560759063357, 3654.2326111516613, 3677.687396571295, 1046.5238316565944, 1066.2749330455288, 1071.566015763617, 1072.9570817167382, 1073.0, 11952.282863028158, 12088.939555302255, 12163.02695784335, 12226.510939562408, 12313.384330783514, 4947.752612369367, 5000.62495312853, 5070.3155074064525, 5073.985202959349, 5084.872878178076, 8598.78503037429, 10415.479226038819, 10578.471076446147, 10595.84106238407, 10609.628662996913, 5514.172874068921, 5553.028220061554, 5559.221708960748, 5623.6906970116215, 5657.43425657431, 4585.564371384713, 4997.675151115166, 5048.495150484996, 5080.958403527268, 5146.408163061221, 4276.1661476012505, 4284.1645879053285, 4293.570642935744, 4315.805788739514, 4394.231009573376, 1117.6591139702468, 1379.655086228443, 1418.758811002132, 1422.5661173342023, 1429.6497358147112, 919.4850883505259, 936.3492372800974, 965.4786415335781, 985.8126955878504, 987.3730181334904, 5836.328822185418, 5873.970630146908, 6040.546958978094, 6062.878742425127, 6146.385361463907, 929.9442033478012, 993.1359717046216, 993.8062077894741, 1032.4682788363998, 1054.3726482742757, 3998.140399814054, 4020.336644453691, 4071.572484889044, 4105.096878686684, 4120.17596480705, 10730.463476826128, 10965.725856853642, 11069.391183484824, 11095.889041109485, 11174.776504470028, 10728.088112510524, 10738.73153171177, 10792.136629069655, 10801.243912926177, 10840.457977101114, 8601.0, 8615.6984505542, 8673.609687564074, 8697.782555436164, 8739.388242823068, 6010.789622363196, 6023.969880150571, 6089.421504957022, 6147.661878596541, 6189.102580125947, 9562.599962250513, 9791.706248812547, 9895.703128906145, 10005.0, 10162.695119146438, 8598.82802343962, 10217.489125543842, 10249.692509224436, 10278.434686092336, 10322.793544129225, 7759.7672069838, 8292.83414331722, 8400.0, 8492.532910689724, 8666.393352465268, 8449.366297527833, 8462.449940753831, 8532.23209911086, 8536.573171341532, 8632.136786321318, 7568.508046976929, 7706.7687969361, 7743.806404839924, 7811.257930496594, 7844.058712954482, 7494.587797671181, 7537.397008239437, 7571.053618297713, 7576.583287919218, 7652.923470765221, 7267.273272672691, 7321.670524826289, 7327.670254838438, 7343.339099480859, 7344.669489872862, 4412.558744125562, 4838.03239352138, 4909.631777616622, 5055.34280543527, 5103.617228707788, 5095.541401273755, 5110.3356563646485, 5149.0, 5221.738913054408, 5358.303420555459], "value": 4789.599037809818, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.64694747041864, 334.95143204235404, 335.9916002099948, 341.51334348553314, 347.0750450050615, 5611.523020543259, 6922.134733158356, 6959.234484206733, 6988.685509152087, 7046.436285097187, 6902.068220790192, 6914.066601008863, 6920.688569014394, 6929.653517324139, 6947.131608548932, 4925.039617274624, 4986.850394488171, 5116.846494605168, 5140.203268493389, 5140.614453915952, 5022.397312322508, 5102.591792656597, 5116.744162791864, 5128.461511541291, 5136.717480538568, 4995.325631039799, 5056.8482945511505, 5077.238414237875, 5079.1365467870555, 5134.922976155361, 4483.0, 5123.462036486171, 5125.256837758504, 5130.948690513103, 5138.203578445347, 4386.956130438687, 4387.62705170061, 4391.01202229499, 4395.494518130424, 4400.713953593006, 5401.378841433207, 6468.611883287018, 6713.664316784141, 6747.932520674829, 6748.8312792180095, 5942.524598032147, 5972.9701351493395, 5995.340512543617, 5995.640261584319, 6001.189839371673, 7455.5526668399525, 7478.06524184477, 7491.66287517063, 7495.700171993114, 7501.399888009001, 4334.9783251083545, 4502.819887204508, 4783.4977327380475, 4796.208625576775, 4807.30294107356, 7069.222385537587, 7406.148292946326, 7661.310482056641, 7831.530108193527, 7911.367090632735, 4394.758288294174, 4828.155072862235, 4867.415910090741, 4874.8787778810365, 4879.072976134523, 4671.649626277975, 4951.851444456672, 4968.577670897942, 4970.478099799469, 4971.632800979687, 5170.741462926839, 5722.685252311079, 5964.433378829004, 5966.940330596639, 5970.313413957364, 7509.474336796372, 7517.849643007109, 7549.131849837229, 7557.244275572399, 7570.735024274234, 1649.6123410998405, 1703.608170120879, 1726.180064469367, 1729.6454226883711, 1730.5846596816925, 1073.7423018475665, 1082.767205050902, 1090.2695194219891, 1092.6885837536263, 1094.5238821112682, 6775.356341147583, 6867.656617169122, 6877.312268773083, 6880.383109969153, 6908.689108990107, 7477.925220747723, 7692.307692307607, 7721.575313357819, 7732.6133693315105, 7735.0, 7123.287671232835, 7149.642517874189, 7167.319104685047, 7169.533980291264, 7188.964055179691, 4132.979335103305, 4135.937960930589, 4172.4784401949755, 4176.1230141670585, 4176.227397931392, 8203.958980205061, 8244.793880153044, 8248.793780155544, 8262.669493220325, 8274.13121622221, 7862.606869656494, 8063.27430531255, 8121.228483294078, 8133.389995750343, 8140.75577732669, 6285.371462853769, 7977.960110199412, 8191.017077950565, 8228.753137405887, 8249.79375515617, 7868.134505204537, 7872.094709108297, 7879.330256927996, 7893.644785984529, 7896.289333959971, 7383.8154046149275, 7701.268379503938, 7720.189380115232, 7739.18738532446, 7739.806504837424, 6787.115475922812, 8368.41421100517, 8428.0, 8430.747077587683, 8457.154284571494, 4010.7994600269285, 4864.586510146536, 4866.853994380174, 4867.787260408114, 4886.975565122151, 6757.297081167572, 7855.567943763148, 7880.2513761192595, 7908.723194688158, 7923.445358825057, 6147.385261473817, 7234.638268086469, 7536.0, 7562.016937798051, 7580.583067931317, 7493.4379921505015, 7553.357964573072, 7559.886601700869, 7561.7731468056045, 7592.734254301073, 7332.706691732271, 7355.889661654973, 7365.558066516026, 7376.631168441664, 7405.407567394704, 7538.283863033003, 7567.281108294924, 7572.7728168155045, 7589.58257295854, 7608.0489938757655, 7002.544834585736, 7278.526895751759, 7305.634718263959, 7309.853802924018, 7394.038774959436], "value": 5423.953602891875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.8900975843866, 742.7326162581471, 766.4404984361416, 776.5806464509162, 787.5471603827797, 15553.688926221483, 15847.366105355772, 15877.0, 16163.676726465479, 16189.595260118504, 14769.261536923137, 14858.628534286649, 14861.405543778263, 14888.925555372209, 14893.478728244514, 753.9736109236178, 918.07733228106, 928.5496534180951, 953.0421925964396, 954.2461455450186, 940.2102234123334, 945.4327403557879, 952.4475804033644, 952.8189643967659, 955.9044095590455, 973.5862258540128, 975.6780262513389, 1005.4570531912794, 1007.4660429972126, 1014.2849291249652, 884.8585324930864, 963.8650588917557, 1008.2236677758159, 1008.3042700536643, 1012.6000229909218, 734.5702763883135, 735.7608777147449, 740.6037769793189, 760.6120878352081, 768.2624680306913, 15161.469348572857, 15170.469033583771, 15173.772393414107, 15503.612409689847, 15581.454649087342, 12747.107702460831, 12768.744625107445, 13373.398197081155, 13417.313462444477, 13540.526081587195, 9786.168175705074, 9835.672184255105, 10248.0, 10426.402891002592, 10461.267711260214, 3596.5863925648623, 3598.1904071583685, 3648.233870887117, 3695.8336874840697, 3858.7298889077774, 84028.0, 84198.0, 84314.57842710747, 84484.57757711233, 84945.57527212324, 8698.913010869937, 9652.662156824617, 9752.512374381253, 9771.267154963407, 10050.396976181453, 22825.885870570542, 22841.543169136523, 22935.54128917412, 23327.0, 23809.880950595136, 7579.469437139458, 7706.614669266626, 7725.266099720518, 7767.02912135983, 7852.84294314122, 4169.541350451448, 4210.873673789792, 4231.048014196843, 4233.1322078973735, 4233.259179643612, 3771.4908487353855, 3819.84720611178, 3846.826892789831, 3849.287881741831, 3854.997700597865, 610.1732152932801, 652.797632733854, 719.8596273726678, 726.1934207271828, 767.3017554025921, 569.9259096317452, 604.9637021778619, 613.910982907476, 617.6664601115438, 625.4738438210751, 8243.876341854877, 8498.065212826585, 8537.317014638815, 8628.913710862937, 8712.194781846563, 517.4049842680872, 554.6367129530164, 618.0759764152621, 624.9093881387173, 638.409471239102, 3526.9419174247623, 3760.1163726524246, 3998.5001874765653, 4001.8199181036925, 4018.7588744675413, 89525.0, 91951.0, 97303.51348243355, 99805.0, 100088.0, 58786.41213587809, 75781.0, 81099.0, 81108.59445702734, 83121.16878831256, 65007.69984600281, 65285.36786580373, 68103.3189668107, 71346.64326678333, 73939.26060739432, 8167.469114507538, 8229.135940726137, 8379.916200837913, 8503.8724419135, 8619.569021549023, 51362.74318628383, 51465.0, 52639.21041184462, 53204.46795531995, 53240.73379633077, 62204.688976554826, 65802.67098664476, 67096.32903670901, 67259.0, 68186.0, 11154.776904461703, 11264.662060137882, 11370.658880233606, 11509.07927365792, 11743.823842642196, 12021.158518903592, 12209.0, 12291.631251062483, 12483.0, 12505.874941250835, 9660.516974151406, 11781.469833857325, 11812.62526049227, 11906.76186476283, 12045.735781814652, 10985.90140985927, 11507.42462876836, 11722.23805452677, 11842.11184161174, 12017.077267637136, 9451.763705907408, 10201.948990255298, 10417.801952775224, 11740.41297935117, 11862.169648124893, 9243.260539156985, 9853.396326711205, 10004.099631033241, 10115.241356898408, 10213.693589192337, 9982.101610855058, 10096.293259471766, 10126.696199114038, 10205.234607404325, 10211.029952154533], "value": 7111.344645264528, "unit": "score"}], "name": "dromaeo_css", "value": 7725.799782683816, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 121.0, 169.0, 127.0, 116.0, 105.0, 115.0, 115.0, 115.0], "value": 121.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 147.0, 160.0, 118.0, 141.0, 144.0, 189.0, 153.0, 152.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 201.0, 197.0, 209.0, 195.0, 196.0, 199.0, 195.0, 196.0, 197.0], "value": 198.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 107.0, 104.0, 172.0, 57.0, 56.0, 55.0, 67.0, 128.0, 57.0], "value": 86.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 130.0, 77.0, 80.0, 84.0, 122.0, 80.0, 79.0, 124.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 90.0, 88.0, 91.0, 88.0, 91.0, 89.0, 97.0, 88.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 128.0, 95.0, 96.0, 96.0, 97.0, 97.0, 96.0, 95.0, 96.0], "value": 101.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 89.0, 91.0, 90.0, 91.0, 90.0, 113.0, 146.0, 114.0], "value": 100.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 63.0, 63.0, 66.0, 64.0, 73.0, 106.0, 94.0, 85.0], "value": 73.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 64.0, 70.0, 75.0, 76.0, 68.0, 65.0, 65.0, 67.0], "value": 68.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 79.0, 80.0, 82.0, 80.0, 80.0, 106.0, 107.0, 83.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 155.0, 149.0, 147.0, 144.0, 146.0, 133.0, 148.0, 168.0, 153.0], "value": 148.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 166.0, 163.0, 170.0, 210.0, 160.0, 165.0, 160.0, 161.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 66.0, 67.0, 67.0, 69.0, 67.0, 68.0, 73.0, 68.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1552.3999999999999, "alertThreshold": 2.0}]} 10:23:02 INFO - Return code: 0 10:23:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:23:02 ERROR - # TBPL SUCCESS # 10:23:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:23:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:23:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:23:02 INFO - 2016-06-28 10:23:02.618 screenresolution[1688:10794] starting screenresolution argv=screenresolution get 10:23:02 INFO - 2016-06-28 10:23:02.620 screenresolution[1688:10794] Display 0: 1600x1200x32@60 10:23:02 INFO - 2016-06-28 10:23:02.626 screenresolution[1689:10797] starting screenresolution argv=screenresolution list 10:23:02 INFO - Available Modes on Display 0 10:23:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:23:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:23:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:23:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:23:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:23:02 INFO - Intel Iris: 10:23:02 INFO - Chipset Model: Intel Iris 10:23:02 INFO - Type: GPU 10:23:02 INFO - Bus: Built-In 10:23:02 INFO - VRAM (Dynamic, Max): 1536 MB 10:23:02 INFO - Vendor: Intel (0x8086) 10:23:02 INFO - Device ID: 0x0a2e 10:23:02 INFO - Revision ID: 0x0009 10:23:02 INFO - Displays: 10:23:02 INFO - Display: 10:23:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:23:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:23:02 INFO - Display Serial Number: 1600x1200 60 10:23:02 INFO - Main Display: Yes 10:23:02 INFO - Mirror: Off 10:23:02 INFO - Online: Yes 10:23:02 INFO - Rotation: Supported 10:23:02 INFO - Return code: 0 10:23:02 INFO - Running post-action listener: _resource_record_post_action 10:23:02 INFO - Running post-run listener: _resource_record_post_run 10:23:03 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 37778944; Write bytes: 493245952; Read time: 401; Write time: 1681 10:23:03 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 196700672; Write bytes: 186009600; Read time: 17417; Write time: 371 10:23:03 INFO - run-tests - Wall time: 1171s; CPU: 54.0%; Read bytes: 30604800; Write bytes: 296447488; Read time: 311; Write time: 1278 10:23:03 INFO - Running post-run listener: _upload_blobber_files 10:23:03 INFO - Blob upload gear active. 10:23:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:23:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:23:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:23:04 INFO - (blobuploader) - INFO - Open directory for files ... 10:23:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:23:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:23:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:05 INFO - (blobuploader) - INFO - Done attempting. 10:23:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:23:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:23:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:06 INFO - (blobuploader) - INFO - Done attempting. 10:23:06 INFO - (blobuploader) - INFO - Iteration through files over. 10:23:06 INFO - Return code: 0 10:23:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:23:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:23:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2dd1b3f083b5bc94991e79f6c65d66709e7c28a75c8412ee4d4d862ac1bf35bf14c833b97ebdb96e18f20bd0a4d196798921fb6116ebef5a05327837cc619022", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/797f0be132450a9a9be445913b1f6ce616a07767ca03e0bd10c676db661b16a4ae45345a203ad0b4eff71d6db6b7dd1864ac8adfb361121beea4a8665df1ee0c"} 10:23:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:23:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:23:06 INFO - Contents: 10:23:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2dd1b3f083b5bc94991e79f6c65d66709e7c28a75c8412ee4d4d862ac1bf35bf14c833b97ebdb96e18f20bd0a4d196798921fb6116ebef5a05327837cc619022", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/797f0be132450a9a9be445913b1f6ce616a07767ca03e0bd10c676db661b16a4ae45345a203ad0b4eff71d6db6b7dd1864ac8adfb361121beea4a8665df1ee0c"} 10:23:06 INFO - Running post-run listener: copy_logs_to_upload_dir 10:23:06 INFO - Copying logs to upload dir... 10:23:06 INFO - mkdir: /builds/slave/test/build/upload/logs 10:23:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.554467 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-28 10:23:06.558773) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 10:23:06.562444) ========= 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.Mu5eepnw5g/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.XCdOJ9yfqQ/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2dd1b3f083b5bc94991e79f6c65d66709e7c28a75c8412ee4d4d862ac1bf35bf14c833b97ebdb96e18f20bd0a4d196798921fb6116ebef5a05327837cc619022", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/797f0be132450a9a9be445913b1f6ce616a07767ca03e0bd10c676db661b16a4ae45345a203ad0b4eff71d6db6b7dd1864ac8adfb361121beea4a8665df1ee0c"} build_url:https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010982 build_url: 'https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2dd1b3f083b5bc94991e79f6c65d66709e7c28a75c8412ee4d4d862ac1bf35bf14c833b97ebdb96e18f20bd0a4d196798921fb6116ebef5a05327837cc619022", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/797f0be132450a9a9be445913b1f6ce616a07767ca03e0bd10c676db661b16a4ae45345a203ad0b4eff71d6db6b7dd1864ac8adfb361121beea4a8665df1ee0c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 10:23:06.597346) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:23:06.597640) ========= 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.Mu5eepnw5g/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.XCdOJ9yfqQ/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.005281 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:23:06.646663) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 10:23:06.646958) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 10:23:06.647270) ========= ========= Total master_lag: 0.51 =========