builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0367 starttime: 1463161409.87 results: success (0) buildid: 20160513090035 builduid: 5ba24935d4164d6f9036414264444526 revision: a225f011dec1e24bb17e9c3ab0df54ac95875d34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:29.870283) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:29.871108) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:29.871628) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:29.933273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:29.933627) ========= 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.4YakC2GtoC/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.qhMFNckQlX/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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-05-13 10:43:29-- 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% 211M=0s 2016-05-13 10:43:30 (211 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165404 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:30.145487) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:30.145797) ========= 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.4YakC2GtoC/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.qhMFNckQlX/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.019853 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:30.196394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 10:43:30.196762) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a225f011dec1e24bb17e9c3ab0df54ac95875d34 --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 a225f011dec1e24bb17e9c3ab0df54ac95875d34 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4YakC2GtoC/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.qhMFNckQlX/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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-05-13 10:43:30,269 truncating revision to first 12 chars 2016-05-13 10:43:30,269 Setting DEBUG logging. 2016-05-13 10:43:30,269 attempt 1/10 2016-05-13 10:43:30,269 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a225f011dec1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 10:43:31,854 unpacking tar archive at: mozilla-beta-a225f011dec1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.836640 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 10:43:32.083242) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:32.083580) ========= script_repo_revision: a225f011dec1e24bb17e9c3ab0df54ac95875d34 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:32.084036) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:32.084333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:32.097735) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2016-05-13 10:43:32.098126) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4YakC2GtoC/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.qhMFNckQlX/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:43:32 INFO - MultiFileLogger online at 20160513 10:43:32 in /builds/slave/test 10:43:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:43:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:43:32 INFO - {'append_to_log': False, 10:43:32 INFO - 'base_work_dir': '/builds/slave/test', 10:43:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:43:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:43:32 INFO - 'branch': 'Mozilla-Beta', 10:43:32 INFO - 'buildbot_json_path': 'buildprops.json', 10:43:32 INFO - 'config_files': ('talos/mac_config.py',), 10:43:32 INFO - 'default_actions': ('clobber', 10:43:32 INFO - 'read-buildbot-config', 10:43:32 INFO - 'download-and-extract', 10:43:32 INFO - 'populate-webroot', 10:43:32 INFO - 'create-virtualenv', 10:43:32 INFO - 'install', 10:43:32 INFO - 'run-tests'), 10:43:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:43:32 INFO - 'download_minidump_stackwalk': True, 10:43:32 INFO - 'download_symbols': 'ondemand', 10:43:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:43:32 INFO - 'tooltool.py': '/tools/tooltool.py', 10:43:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:43:32 INFO - '/tools/misc-python/virtualenv.py')}, 10:43:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:43:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:43:32 INFO - 'installer_path': 'installer.exe', 10:43:32 INFO - 'log_level': 'info', 10:43:32 INFO - 'log_name': 'talos', 10:43:32 INFO - 'log_to_console': True, 10:43:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:43:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:43:32 INFO - 'opt_config_files': (), 10:43:32 INFO - 'pip_index': False, 10:43:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:43:32 INFO - 'cmd': ('bash', 10:43:32 INFO - '-c', 10:43:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:43:32 INFO - 'enabled': True, 10:43:32 INFO - 'halt_on_failure': False, 10:43:32 INFO - 'name': 'check_screen_resolution'},), 10:43:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:43:32 INFO - 'cmd': ('bash', 10:43:32 INFO - '-c', 10:43:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:43:32 INFO - 'enabled': True, 10:43:32 INFO - 'halt_on_failure': False, 10:43:32 INFO - 'name': 'check_screen_resolution'},), 10:43:32 INFO - 'run_cmd_checks_enabled': True, 10:43:32 INFO - 'sps_profile': False, 10:43:32 INFO - 'sps_profile_interval': 0, 10:43:32 INFO - 'suite': 'dromaeojs', 10:43:32 INFO - 'system_bits': '32', 10:43:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:43:32 INFO - 'title': 't-yosemite-r7-0367', 10:43:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:43:32 INFO - 'use_talos_json': True, 10:43:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:43:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:43:32 INFO - 'work_dir': 'build'} 10:43:32 INFO - ##### 10:43:32 INFO - ##### Running clobber step. 10:43:32 INFO - ##### 10:43:32 INFO - Running pre-action listener: _resource_record_pre_action 10:43:32 INFO - Running main action method: clobber 10:43:32 INFO - rmtree: /builds/slave/test/build 10:43:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:43:33 INFO - Running post-action listener: _resource_record_post_action 10:43:33 INFO - ##### 10:43:33 INFO - ##### Running read-buildbot-config step. 10:43:33 INFO - ##### 10:43:33 INFO - Running pre-action listener: _resource_record_pre_action 10:43:33 INFO - Running main action method: read_buildbot_config 10:43:33 INFO - Using buildbot properties: 10:43:33 INFO - { 10:43:33 INFO - "project": "", 10:43:33 INFO - "product": "firefox", 10:43:33 INFO - "script_repo_revision": "production", 10:43:33 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:43:33 INFO - "repository": "", 10:43:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:43:33 INFO - "buildid": "20160513090035", 10:43:33 INFO - "pgo_build": "False", 10:43:33 INFO - "basedir": "/builds/slave/test", 10:43:33 INFO - "buildnumber": 10, 10:43:33 INFO - "slavename": "t-yosemite-r7-0367", 10:43:33 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 10:43:33 INFO - "platform": "yosemite_r7", 10:43:33 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:43:33 INFO - "branch": "mozilla-beta", 10:43:33 INFO - "repo_path": "releases/mozilla-beta", 10:43:33 INFO - "revision": "a225f011dec1e24bb17e9c3ab0df54ac95875d34", 10:43:33 INFO - "stage_platform": "macosx64", 10:43:33 INFO - "builduid": "5ba24935d4164d6f9036414264444526", 10:43:33 INFO - "slavebuilddir": "test" 10:43:33 INFO - } 10:43:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 10:43:33 INFO - Running post-action listener: _resource_record_post_action 10:43:33 INFO - ##### 10:43:33 INFO - ##### Running download-and-extract step. 10:43:33 INFO - ##### 10:43:33 INFO - Running pre-action listener: _resource_record_pre_action 10:43:33 INFO - Running main action method: download_and_extract 10:43:33 INFO - mkdir: /builds/slave/test/build/tests 10:43:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:33 INFO - https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:43:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:43:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:43:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:43:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 10:43:39 INFO - Downloaded 1241 bytes. 10:43:39 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:43:39 INFO - Using the following test package requirements: 10:43:39 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:43:39 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:43:39 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 10:43:39 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:43:39 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 10:43:39 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:43:39 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:43:39 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 10:43:39 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:43:39 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:43:39 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 10:43:39 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:43:39 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 10:43:39 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:43:39 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 10:43:39 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:43:39 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:43:39 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 10:43:39 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 10:43: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:43:39 INFO - https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:43:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:43:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:43:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:43:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:43:44 INFO - Downloaded 17747433 bytes. 10:43:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:43:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:43:47 INFO - Return code: 0 10:43:47 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:47 INFO - https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:43:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:43:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:43:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:43:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:43:52 INFO - Downloaded 17747433 bytes. 10:43:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:43:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:43:56 INFO - Return code: 0 10:43: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:43:56 INFO - https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:43:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:43:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:43:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 10:43:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 10:43:57 INFO - Downloaded 10845194 bytes. 10:43:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:43:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:43:57 INFO - Return code: 0 10:43:57 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:43:57 INFO - https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 10:43:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:43:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:43:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 10:43:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 10:44:03 INFO - Downloaded 88270297 bytes. 10:44:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:44:03 INFO - mkdir: /builds/slave/test/properties 10:44:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:44:03 INFO - Writing to file /builds/slave/test/properties/build_url 10:44:03 INFO - Contents: 10:44:03 INFO - build_url:https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:44:04 INFO - Running post-action listener: _resource_record_post_action 10:44:04 INFO - Running post-action listener: set_extra_try_arguments 10:44:04 INFO - ##### 10:44:04 INFO - ##### Running populate-webroot step. 10:44:04 INFO - ##### 10:44:04 INFO - Running pre-action listener: _resource_record_pre_action 10:44:04 INFO - Running main action method: populate_webroot 10:44:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:44:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:44:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:44:04 INFO - '--tppagecycles', 10:44:04 INFO - '7'], 10:44:04 INFO - 'tests': ['tsvgm']}}, 10:44:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:44:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:44:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:44:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:44:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:44:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:44:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:44:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:04 INFO - 'talos_options': ['--e10s'], 10:44:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:44:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:04 INFO - 'tests': ['damp', 'tps']}, 10:44:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:04 INFO - 'talos_options': ['--e10s'], 10:44:04 INFO - 'tests': ['damp', 'tps']}, 10:44:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:44:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:44:04 INFO - 'other': {'tests': ['a11yr', 10:44:04 INFO - 'ts_paint', 10:44:04 INFO - 'tpaint', 10:44:04 INFO - 'sessionrestore', 10:44:04 INFO - 'sessionrestore_no_auto_restore', 10:44:04 INFO - 'tabpaint']}, 10:44:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:44:04 INFO - 'tests': ['a11yr', 10:44:04 INFO - 'ts_paint', 10:44:04 INFO - 'tpaint', 10:44:04 INFO - 'sessionrestore', 10:44:04 INFO - 'sessionrestore_no_auto_restore', 10:44:04 INFO - 'tabpaint']}, 10:44:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:44:04 INFO - 'tests': ['a11yr', 10:44:04 INFO - 'ts_paint', 10:44:04 INFO - 'tpaint', 10:44:04 INFO - 'sessionrestore', 10:44:04 INFO - 'sessionrestore_no_auto_restore', 10:44:04 INFO - 'tabpaint']}, 10:44:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:44:04 INFO - 'tests': ['a11yr', 10:44:04 INFO - 'ts_paint', 10:44:04 INFO - 'tpaint', 10:44:04 INFO - 'sessionrestore', 10:44:04 INFO - 'sessionrestore_no_auto_restore', 10:44:04 INFO - 'tabpaint']}, 10:44:04 INFO - 'other_l64': {'tests': ['a11yr', 10:44:04 INFO - 'ts_paint', 10:44:04 INFO - 'tpaint', 10:44:04 INFO - 'sessionrestore', 10:44:04 INFO - 'sessionrestore_no_auto_restore', 10:44:04 INFO - 'tabpaint']}, 10:44:04 INFO - 'other_nol64': {'tests': ['a11yr', 10:44:04 INFO - 'ts_paint', 10:44:04 INFO - 'tpaint', 10:44:04 INFO - 'sessionrestore', 10:44:04 INFO - 'sessionrestore_no_auto_restore', 10:44:04 INFO - 'tabpaint']}, 10:44:04 INFO - 'svgr': {'tests': ['tsvgx', 10:44:04 INFO - 'tsvgr_opacity', 10:44:04 INFO - 'tart', 10:44:04 INFO - 'tscrollx', 10:44:04 INFO - 'cart']}, 10:44:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:44:04 INFO - 'tests': ['tsvgx', 10:44:04 INFO - 'tsvgr_opacity', 10:44:04 INFO - 'tart', 10:44:04 INFO - 'tscrollx', 10:44:04 INFO - 'cart']}, 10:44:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:04 INFO - 'tests': ['tp5o']}, 10:44:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:04 INFO - 'talos_options': ['--e10s'], 10:44:04 INFO - 'tests': ['tp5o']}, 10:44:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:04 INFO - 'talos_options': ['--xperf_path', 10:44:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:44:04 INFO - 'tests': ['tp5n']}, 10:44:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:04 INFO - 'talos_options': ['--e10s', 10:44:04 INFO - '--xperf_path', 10:44:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:44:04 INFO - 'tests': ['tp5n']}}, 10:44:04 INFO - 'talos.zip': {'path': '', 10:44:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:44:04 INFO - Running post-action listener: _resource_record_post_action 10:44:04 INFO - ##### 10:44:04 INFO - ##### Running create-virtualenv step. 10:44:04 INFO - ##### 10:44:04 INFO - Running pre-action listener: _resource_record_pre_action 10:44:04 INFO - Running main action method: create_virtualenv 10:44:04 INFO - Creating virtualenv /builds/slave/test/build/venv 10:44:04 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:44:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:44:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:44:04 INFO - Using real prefix '/tools/python27' 10:44:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:44:05 INFO - Installing distribute.............................................................................................................................................................................................done. 10:44:08 INFO - Installing pip.................done. 10:44:08 INFO - Return code: 0 10:44:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:08 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d25c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x109808db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.4YakC2GtoC/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.qhMFNckQlX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:44:08 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:44:08 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:44:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YakC2GtoC/Render', 10:44:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:08 INFO - 'HOME': '/Users/cltbld', 10:44:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:08 INFO - 'LOGNAME': 'cltbld', 10:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:08 INFO - 'MOZ_NO_REMOTE': '1', 10:44:08 INFO - 'NO_EM_RESTART': '1', 10:44:08 INFO - 'PAGER': '/bin/cat', 10:44:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:08 INFO - 'PWD': '/builds/slave/test', 10:44:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:08 INFO - 'SHELL': '/bin/bash', 10:44:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qhMFNckQlX/Listeners', 10:44:08 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:44:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:08 INFO - 'USER': 'cltbld', 10:44:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:08 INFO - 'XPC_FLAGS': '0x0', 10:44:08 INFO - 'XPC_SERVICE_NAME': '0', 10:44:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:08 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:44:08 INFO - Cleaning up... 10:44:08 INFO - Return code: 0 10:44:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:08 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d25c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x109808db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.4YakC2GtoC/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.qhMFNckQlX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:44:08 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:44:08 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:44:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YakC2GtoC/Render', 10:44:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:08 INFO - 'HOME': '/Users/cltbld', 10:44:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:08 INFO - 'LOGNAME': 'cltbld', 10:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:08 INFO - 'MOZ_NO_REMOTE': '1', 10:44:08 INFO - 'NO_EM_RESTART': '1', 10:44:08 INFO - 'PAGER': '/bin/cat', 10:44:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:08 INFO - 'PWD': '/builds/slave/test', 10:44:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:08 INFO - 'SHELL': '/bin/bash', 10:44:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qhMFNckQlX/Listeners', 10:44:08 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:44:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:08 INFO - 'USER': 'cltbld', 10:44:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:08 INFO - 'XPC_FLAGS': '0x0', 10:44:08 INFO - 'XPC_SERVICE_NAME': '0', 10:44:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:08 INFO - Downloading/unpacking psutil>=0.7.1 10:44: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:44: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:44: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:44: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:44: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:44: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:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:44:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:44:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:44:11 INFO - Installing collected packages: psutil 10:44:11 INFO - Running setup.py install for psutil 10:44:11 INFO - building 'psutil._psutil_osx' extension 10:44:11 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:44:11 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:44:11 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:44:11 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:44:11 INFO - building 'psutil._psutil_posix' extension 10:44:11 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:44:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:44:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:44:11 INFO - ^ 10:44:11 INFO - 1 warning generated. 10:44:11 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:44:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:44:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:44:12 INFO - Successfully installed psutil 10:44:12 INFO - Cleaning up... 10:44:12 INFO - Return code: 0 10:44:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:44:12 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:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:12 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:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:12 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d25c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x109808db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.4YakC2GtoC/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.qhMFNckQlX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:44:12 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:44:12 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:44:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YakC2GtoC/Render', 10:44:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:12 INFO - 'HOME': '/Users/cltbld', 10:44:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:12 INFO - 'LOGNAME': 'cltbld', 10:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:12 INFO - 'MOZ_NO_REMOTE': '1', 10:44:12 INFO - 'NO_EM_RESTART': '1', 10:44:12 INFO - 'PAGER': '/bin/cat', 10:44:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:12 INFO - 'PWD': '/builds/slave/test', 10:44:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:12 INFO - 'SHELL': '/bin/bash', 10:44:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qhMFNckQlX/Listeners', 10:44:12 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:44:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:12 INFO - 'USER': 'cltbld', 10:44:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:12 INFO - 'XPC_FLAGS': '0x0', 10:44:12 INFO - 'XPC_SERVICE_NAME': '0', 10:44:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:44:12 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:44:12 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:44:12 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:44:12 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:44:12 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:44:12 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:44:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:44:14 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:44:14 INFO - Installing collected packages: mozsystemmonitor 10:44:14 INFO - Running setup.py install for mozsystemmonitor 10:44:15 INFO - Successfully installed mozsystemmonitor 10:44:15 INFO - Cleaning up... 10:44:15 INFO - Return code: 0 10:44:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:15 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d25c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x109808db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.4YakC2GtoC/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.qhMFNckQlX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:44:15 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:44:15 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:44:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YakC2GtoC/Render', 10:44:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:15 INFO - 'HOME': '/Users/cltbld', 10:44:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:15 INFO - 'LOGNAME': 'cltbld', 10:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:15 INFO - 'MOZ_NO_REMOTE': '1', 10:44:15 INFO - 'NO_EM_RESTART': '1', 10:44:15 INFO - 'PAGER': '/bin/cat', 10:44:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:15 INFO - 'PWD': '/builds/slave/test', 10:44:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:15 INFO - 'SHELL': '/bin/bash', 10:44:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qhMFNckQlX/Listeners', 10:44:15 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:44:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:15 INFO - 'USER': 'cltbld', 10:44:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:15 INFO - 'XPC_FLAGS': '0x0', 10:44:15 INFO - 'XPC_SERVICE_NAME': '0', 10:44:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:15 INFO - Downloading/unpacking blobuploader==1.2.4 10:44:15 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:44:15 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:44:15 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:44:15 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:44:15 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:44:15 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:44:17 INFO - Downloading blobuploader-1.2.4.tar.gz 10:44:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:44:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:44:17 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:44:17 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:44:17 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:44:17 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:44:17 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:44:17 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:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:44:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:44:18 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:44:18 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:44:18 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:44:18 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:44:18 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:44:18 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:44:18 INFO - Downloading docopt-0.6.1.tar.gz 10:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:44:19 INFO - Installing collected packages: blobuploader, requests, docopt 10:44:19 INFO - Running setup.py install for blobuploader 10:44:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:44:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:44:19 INFO - Running setup.py install for requests 10:44:19 INFO - Running setup.py install for docopt 10:44:19 INFO - Successfully installed blobuploader requests docopt 10:44:19 INFO - Cleaning up... 10:44:19 INFO - Return code: 0 10:44:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:44: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:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44: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:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:19 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d25c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x109808db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.4YakC2GtoC/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.qhMFNckQlX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:44:19 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:44:19 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:44:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YakC2GtoC/Render', 10:44:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:19 INFO - 'HOME': '/Users/cltbld', 10:44:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:19 INFO - 'LOGNAME': 'cltbld', 10:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:19 INFO - 'MOZ_NO_REMOTE': '1', 10:44:19 INFO - 'NO_EM_RESTART': '1', 10:44:19 INFO - 'PAGER': '/bin/cat', 10:44:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:19 INFO - 'PWD': '/builds/slave/test', 10:44:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:19 INFO - 'SHELL': '/bin/bash', 10:44:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qhMFNckQlX/Listeners', 10:44:19 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:44:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:19 INFO - 'USER': 'cltbld', 10:44:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:19 INFO - 'XPC_FLAGS': '0x0', 10:44:19 INFO - 'XPC_SERVICE_NAME': '0', 10:44:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:44:20 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-1AfRTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:44:20 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-l7soWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:44:20 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-hroiU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:44:20 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-fgolCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:44:20 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-3Vtpoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:44:20 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-xf5rHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:44:20 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-dvYKLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:44:20 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-z748Hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:44:21 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-PhfBcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:44:21 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-peHFVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:44:21 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-umISHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:44:21 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-Zz4ETq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:44:21 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-q7noJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:44:21 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-TqpCeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:21 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-LhZZg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:44:21 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-EKzRTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:44:21 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ZTe6GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:44:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:44:21 INFO - Running setup.py install for manifestparser 10:44:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:44:22 INFO - Running setup.py install for mozcrash 10:44:22 INFO - Running setup.py install for mozdebug 10:44:22 INFO - Running setup.py install for mozdevice 10:44:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:44:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:44:22 INFO - Running setup.py install for mozfile 10:44:22 INFO - Running setup.py install for mozhttpd 10:44:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:44:22 INFO - Running setup.py install for mozinfo 10:44:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:44:22 INFO - Running setup.py install for mozInstall 10:44:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:44:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:44:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:44:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:44:23 INFO - Running setup.py install for mozleak 10:44:23 INFO - Running setup.py install for mozlog 10:44:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:44:23 INFO - Running setup.py install for moznetwork 10:44:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:44:23 INFO - Running setup.py install for mozprocess 10:44:23 INFO - Running setup.py install for mozprofile 10:44:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:44:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:44:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:44:23 INFO - Running setup.py install for mozrunner 10:44:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:44:24 INFO - Running setup.py install for mozscreenshot 10:44:24 INFO - Running setup.py install for moztest 10:44:24 INFO - Running setup.py install for mozversion 10:44:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:44:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:44:24 INFO - Cleaning up... 10:44:24 INFO - Return code: 0 10:44:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:44: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:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44: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:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:24 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d25c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x109808db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.4YakC2GtoC/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.qhMFNckQlX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:44:24 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:44:24 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:44:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YakC2GtoC/Render', 10:44:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:24 INFO - 'HOME': '/Users/cltbld', 10:44:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:24 INFO - 'LOGNAME': 'cltbld', 10:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:24 INFO - 'MOZ_NO_REMOTE': '1', 10:44:24 INFO - 'NO_EM_RESTART': '1', 10:44:24 INFO - 'PAGER': '/bin/cat', 10:44:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:24 INFO - 'PWD': '/builds/slave/test', 10:44:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:24 INFO - 'SHELL': '/bin/bash', 10:44:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qhMFNckQlX/Listeners', 10:44:24 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:44:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:24 INFO - 'USER': 'cltbld', 10:44:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:24 INFO - 'XPC_FLAGS': '0x0', 10:44:24 INFO - 'XPC_SERVICE_NAME': '0', 10:44:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:44:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-J0rBNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:44:24 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:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:44:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-LNYKie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:44:25 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:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:44:25 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-lHB4Ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:44:25 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:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:44:25 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-IBHfE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:44:25 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:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:44:25 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-AVImfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:44:25 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:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:44:25 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-oCyZR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:44:25 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:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:44:25 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-jcManT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:44:25 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:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:44:25 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-SomiLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:44:25 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:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:44:25 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-Sceu4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:44:25 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:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:44:25 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ulVIb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:44:25 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:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:44:25 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-4kxcD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:44:25 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:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:44:25 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-tHpBvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:44:26 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:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:44:26 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-pA8uog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:44:26 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:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:44:26 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-6vN_ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:44:26 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:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:26 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ds7rxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:26 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:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:44:26 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-2LWE3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:44:26 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:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:44:26 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-mokbVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:44:26 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:44:26 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:44:26 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:44:26 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:44:26 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:44:26 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:44:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:44:26 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:44:26 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:44:26 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:44:26 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:44:26 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:44:26 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:44:29 INFO - Downloading blessings-1.6.tar.gz 10:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:44:29 INFO - Installing collected packages: blessings 10:44:29 INFO - Running setup.py install for blessings 10:44:29 INFO - Successfully installed blessings 10:44:29 INFO - Cleaning up... 10:44:29 INFO - Return code: 0 10:44:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:44:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:44:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:44:29 INFO - Reading from file tmpfile_stdout 10:44:29 INFO - Current package versions: 10:44:29 INFO - blessings == 1.6 10:44:29 INFO - blobuploader == 1.2.4 10:44:29 INFO - docopt == 0.6.1 10:44:29 INFO - manifestparser == 1.1 10:44:29 INFO - mozInstall == 1.12 10:44:29 INFO - mozcrash == 0.17 10:44:29 INFO - mozdebug == 0.1 10:44:29 INFO - mozdevice == 0.48 10:44:29 INFO - mozfile == 1.2 10:44:29 INFO - mozhttpd == 0.7 10:44:29 INFO - mozinfo == 0.9 10:44:29 INFO - mozleak == 0.1 10:44:29 INFO - mozlog == 3.1 10:44:29 INFO - moznetwork == 0.27 10:44:29 INFO - mozprocess == 0.22 10:44:29 INFO - mozprofile == 0.28 10:44:29 INFO - mozrunner == 6.11 10:44:29 INFO - mozscreenshot == 0.1 10:44:29 INFO - mozsystemmonitor == 0.0 10:44:29 INFO - moztest == 0.7 10:44:29 INFO - mozversion == 1.4 10:44:29 INFO - psutil == 3.1.1 10:44:29 INFO - requests == 1.2.3 10:44:29 INFO - wsgiref == 0.1.2 10:44:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:44:29 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:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:29 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:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:29 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d25c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x109808db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.4YakC2GtoC/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.qhMFNckQlX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:44:29 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:44:29 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:44:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YakC2GtoC/Render', 10:44:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:29 INFO - 'HOME': '/Users/cltbld', 10:44:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:29 INFO - 'LOGNAME': 'cltbld', 10:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:29 INFO - 'MOZ_NO_REMOTE': '1', 10:44:29 INFO - 'NO_EM_RESTART': '1', 10:44:29 INFO - 'PAGER': '/bin/cat', 10:44:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:29 INFO - 'PWD': '/builds/slave/test', 10:44:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:29 INFO - 'SHELL': '/bin/bash', 10:44:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qhMFNckQlX/Listeners', 10:44:29 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:44:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:29 INFO - 'USER': 'cltbld', 10:44:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:29 INFO - 'XPC_FLAGS': '0x0', 10:44:29 INFO - 'XPC_SERVICE_NAME': '0', 10:44:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:29 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:44:29 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:44:29 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:44:29 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:44:29 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:44:29 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:44:29 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:44:29 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:44:29 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:44:29 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:44:29 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:44:29 INFO - Cleaning up... 10:44:29 INFO - Return code: 0 10:44:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:44:29 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:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:29 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:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:30 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d25c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x109808db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.4YakC2GtoC/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.qhMFNckQlX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:44:30 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:44:30 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:44:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YakC2GtoC/Render', 10:44:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:30 INFO - 'HOME': '/Users/cltbld', 10:44:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:30 INFO - 'LOGNAME': 'cltbld', 10:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:30 INFO - 'MOZ_NO_REMOTE': '1', 10:44:30 INFO - 'NO_EM_RESTART': '1', 10:44:30 INFO - 'PAGER': '/bin/cat', 10:44:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:30 INFO - 'PWD': '/builds/slave/test', 10:44:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:30 INFO - 'SHELL': '/bin/bash', 10:44:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qhMFNckQlX/Listeners', 10:44:30 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:44:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:30 INFO - 'USER': 'cltbld', 10:44:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:30 INFO - 'XPC_FLAGS': '0x0', 10:44:30 INFO - 'XPC_SERVICE_NAME': '0', 10:44:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:30 INFO - Downloading/unpacking jsonschema 10:44:30 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:44:30 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:44:30 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:44:30 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:44:30 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:44:30 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:44:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:44:32 INFO - Downloading/unpacking functools32 (from jsonschema) 10:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:33 INFO - Downloading functools32-3.2.3-2.tar.gz 10:44:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:44:33 INFO - warning: no files found matching '*.txt' 10:44:33 INFO - no previously-included directories found matching 'build' 10:44:33 INFO - no previously-included directories found matching 'dist' 10:44:33 INFO - no previously-included directories found matching '.git*' 10:44:33 INFO - Installing collected packages: jsonschema, functools32 10:44:33 INFO - Running setup.py install for functools32 10:44:33 INFO - warning: no files found matching '*.txt' 10:44:33 INFO - no previously-included directories found matching 'build' 10:44:33 INFO - no previously-included directories found matching 'dist' 10:44:33 INFO - no previously-included directories found matching '.git*' 10:44:33 INFO - Successfully installed jsonschema functools32 10:44:33 INFO - Cleaning up... 10:44:33 INFO - Return code: 0 10:44:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:33 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d25c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x109808db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.4YakC2GtoC/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.qhMFNckQlX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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:44:33 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:44:33 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:44:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YakC2GtoC/Render', 10:44:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:33 INFO - 'HOME': '/Users/cltbld', 10:44:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:33 INFO - 'LOGNAME': 'cltbld', 10:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:33 INFO - 'MOZ_NO_REMOTE': '1', 10:44:33 INFO - 'NO_EM_RESTART': '1', 10:44:33 INFO - 'PAGER': '/bin/cat', 10:44:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:33 INFO - 'PWD': '/builds/slave/test', 10:44:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:33 INFO - 'SHELL': '/bin/bash', 10:44:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qhMFNckQlX/Listeners', 10:44:33 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:44:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:33 INFO - 'USER': 'cltbld', 10:44:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:33 INFO - 'XPC_FLAGS': '0x0', 10:44:33 INFO - 'XPC_SERVICE_NAME': '0', 10:44:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:33 INFO - Downloading/unpacking flake8 10:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:44:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:44:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:44:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:44:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:44:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:44:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:44:37 INFO - no previously-included directories found matching 'docs/_build' 10:44:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:44:38 INFO - Running setup.py install for pep8 10:44:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:44:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:44:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:44:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:44:38 INFO - no previously-included directories found matching 'docs/_build' 10:44:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:44:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:44:38 INFO - Cleaning up... 10:44:38 INFO - Return code: 0 10:44:38 INFO - Running post-action listener: _resource_record_post_action 10:44:38 INFO - Running post-action listener: _start_resource_monitoring 10:44:38 INFO - Starting resource monitoring. 10:44:38 INFO - ##### 10:44:38 INFO - ##### Running install step. 10:44:38 INFO - ##### 10:44:38 INFO - Running pre-action listener: _resource_record_pre_action 10:44:38 INFO - Running main action method: install 10:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:44:38 INFO - Reading from file tmpfile_stdout 10:44:38 INFO - Detecting whether we're running mozinstall >=1.0... 10:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:44:38 INFO - Reading from file tmpfile_stdout 10:44:38 INFO - Output received: 10:44:38 INFO - Usage: mozinstall [options] installer 10:44:38 INFO - Options: 10:44:38 INFO - -h, --help show this help message and exit 10:44:38 INFO - -d DEST, --destination=DEST 10:44:38 INFO - Directory to install application into. [default: 10:44:38 INFO - "/builds/slave/test"] 10:44:38 INFO - --app=APP Application being installed. [default: firefox] 10:44:38 INFO - mkdir: /builds/slave/test/build/application 10:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:45:01 INFO - Reading from file tmpfile_stdout 10:45:01 INFO - Output received: 10:45:01 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:45:01 INFO - Running post-action listener: _resource_record_post_action 10:45:01 INFO - ##### 10:45:01 INFO - ##### Running run-tests step. 10:45:01 INFO - ##### 10:45:01 INFO - Running pre-action listener: _resource_record_pre_action 10:45:01 INFO - Running main action method: run_tests 10:45:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:45:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:45:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:45:01 INFO - 2016-05-13 10:45:01.177 screenresolution[1914:10403] starting screenresolution argv=screenresolution get 10:45:01 INFO - 2016-05-13 10:45:01.179 screenresolution[1914:10403] Display 0: 1600x1200x32@60 10:45:01 INFO - 2016-05-13 10:45:01.185 screenresolution[1915:10406] starting screenresolution argv=screenresolution list 10:45:01 INFO - Available Modes on Display 0 10:45:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:45:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:45:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:45:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:45:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:45:01 INFO - Intel Iris: 10:45:01 INFO - Chipset Model: Intel Iris 10:45:01 INFO - Type: GPU 10:45:01 INFO - Bus: Built-In 10:45:01 INFO - VRAM (Dynamic, Max): 1536 MB 10:45:01 INFO - Vendor: Intel (0x8086) 10:45:01 INFO - Device ID: 0x0a2e 10:45:01 INFO - Revision ID: 0x0009 10:45:01 INFO - Displays: 10:45:01 INFO - Display: 10:45:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:45:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:45:01 INFO - Display Serial Number: 1600x1200 60 10:45:01 INFO - Main Display: Yes 10:45:01 INFO - Mirror: Off 10:45:01 INFO - Online: Yes 10:45:01 INFO - Rotation: Supported 10:45:01 INFO - Return code: 0 10:45:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:45:01 INFO - Python 2.7.3 10:45:01 INFO - Return code: 0 10:45:01 INFO - grabbing minidump binary from tooltool 10:45: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:45:01 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 0x1099a4d30>, '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 0x109808db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:45:01 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:45:01 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:45:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:45:01 INFO - Return code: 0 10:45:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:45:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:45:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:45:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:45:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:45:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:45:02 INFO - Return code: 0 10:45:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0367 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:45:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YakC2GtoC/Render', 10:45:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:02 INFO - 'HOME': '/Users/cltbld', 10:45:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:02 INFO - 'LOGNAME': 'cltbld', 10:45:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:45:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:02 INFO - 'MOZ_NO_REMOTE': '1', 10:45:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:45:02 INFO - 'NO_EM_RESTART': '1', 10:45:02 INFO - 'PAGER': '/bin/cat', 10:45:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:02 INFO - 'PWD': '/builds/slave/test', 10:45:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:45:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:02 INFO - 'SHELL': '/bin/bash', 10:45:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qhMFNckQlX/Listeners', 10:45:02 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:45:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:02 INFO - 'USER': 'cltbld', 10:45:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:02 INFO - 'XPC_FLAGS': '0x0', 10:45:02 INFO - 'XPC_SERVICE_NAME': '0', 10:45:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:45:02 INFO - mozversion application_buildid: 20160513090035 10:45:02 INFO - mozversion application_changeset: a225f011dec1e24bb17e9c3ab0df54ac95875d34 10:45:02 INFO - mozversion application_display_name: Firefox 10:45:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:45:02 INFO - mozversion application_name: Firefox 10:45:02 INFO - mozversion application_remotingname: firefox 10:45:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:45:02 INFO - mozversion application_vendor: Mozilla 10:45:02 INFO - mozversion application_version: 47.0 10:45:02 INFO - mozversion platform_buildid: 20160513090035 10:45:02 INFO - mozversion platform_changeset: a225f011dec1e24bb17e9c3ab0df54ac95875d34 10:45:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:45:02 INFO - mozversion platform_version: 47.0 10:45:02 INFO - using testdate: 1463161502 10:45:02 INFO - actual date: 1463161502 10:45:02 INFO - starting webserver on 'localhost:49749' 10:45:02 INFO - SUITE-START | Running 2 tests 10:45:02 INFO - TEST-START | dromaeo_css 10:45:02 INFO - operating with platform_type : mac_ 10:45:02 INFO - Initialising browser for dromaeo_css test... 10:45:02 INFO - TEST-INFO | started process 1933 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpUGnJ4n/profile http://localhost:49749/getInfo.html) 10:45:05 INFO - PROCESS | 1933 | __metrics Screen width/height:1600/1200 10:45:05 INFO - PROCESS | 1933 | colorDepth:24 10:45:05 INFO - PROCESS | 1933 | Browser inner width/height: 1024/689 10:45:05 INFO - PROCESS | 1933 | __metrics 10:45:05 INFO - PROCESS | 1933 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:45:05 INFO - PROCESS | 1933 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:45:05 INFO - TEST-INFO | 1933: exit 0 10:45:05 INFO - Browser initialized. 10:45:05 INFO - Running cycle 1/1 for dromaeo_css test... 10:45:05 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpUGnJ4n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:45:17 INFO - PROCESS | 1936 | RSS: Main: 156770304 10:45:17 INFO - PROCESS | 1936 | 10:46:09 INFO - PROCESS | 1936 | 1463161569266 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:48:18 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49749/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49749/tests/dromaeo/cssquery-ext.html) 10:48:19 INFO - PROCESS | 1936 | RSS: Main: 296374272 10:48:19 INFO - PROCESS | 1936 | 10:51:22 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49749/tests/dromaeo/cssquery-ext.html (next: http://localhost:49749/tests/dromaeo/cssquery-jquery.html) 10:51:22 INFO - PROCESS | 1936 | RSS: Main: 293351424 10:51:22 INFO - PROCESS | 1936 | 10:54:24 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49749/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49749/tests/dromaeo/cssquery-mootools.html) 10:54:25 INFO - PROCESS | 1936 | RSS: Main: 296747008 10:54:25 INFO - PROCESS | 1936 | 10:57:27 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49749/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49749/tests/dromaeo/cssquery-prototype.html) 10:57:28 INFO - PROCESS | 1936 | RSS: Main: 254009344 10:57:28 INFO - PROCESS | 1936 | 11:00:31 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49749/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49749/tests/dromaeo/cssquery-yui.html) 11:00:31 INFO - PROCESS | 1936 | RSS: Main: 256913408 11:00:31 INFO - PROCESS | 1936 | 11:03:34 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:49749/tests/dromaeo/cssquery-yui.html (next: http://localhost:49749/tests/dromaeo/cssquery-dojo.html) 11:03:34 INFO - PROCESS | 1936 | RSS: Main: 302186496 11:03:34 INFO - PROCESS | 1936 | 11:03:34 INFO - PROCESS | 1936 | __start_tp_report 11:03:34 INFO - PROCESS | 1936 | _x_x_mozilla_page_load 11:03:34 INFO - PROCESS | 1936 | _x_x_mozilla_page_load_details 11:03:34 INFO - PROCESS | 1936 | |i|pagename|runs| 11:03:34 INFO - PROCESS | 1936 | |0;dojo.html;3084.6915308469142;3306.504024396341;3632.037510059833;3653.7259705522083;3663.303972245275;5848.064309710437;5866.501347385472;5893.086571581401;5917.9408205917925;5921.703914804259;5881.088431293157;5889.882202355961;5918.230630018103;5923;5952.672603006833;5246.68519888806;5278.340207474056;5309.65487243328;5315.255864179018;5369.838904832842;5405.135178371462;5415.350157981048;5420.295361602986;5425.077736784756;5427;5335.706536140511;5383.650062745909;5388.515033646971;5401.621886467949;5406.972675191721;5399.001184780808;5410.323709536308;5423.755930983076;5433.4566543345945;5475.589330800206;5060.569851562622;5345;5358.4641535846495;5367.302250707422;5372.0330340538685;5696;5750.884982300372;5758;5781.335146458169;5799.101139323411;6276.686165691697;6314.210723659543;6314.400131987454;6323.715432805535;6323.715432805535;5268.841934741964;6241.563090583661;6300.338464461257;6304.401081897213;6348.143000694893;6035.486983606399;6072.908906366408;6074.240719910012;6076.96961515194;6086.056661217518;5378.515933565998;6238.937610623836;6338.207724034496;6407.711652975628;6427.839304017343;6212.502999760009;6238.500919926395;6250.124982502453;6278.46633036197;6355.078513615592;5519.668819870821;6164.845878853064;6314.431701146918;6343.936560634427;6350.0792385103905;6266.216722909637;6277.591956522902;6303.6532990685955;6317.557770956081;6327.367263273636;5027.271045698353;5776.104703770922;6246.063090536456;6272.560920735505;6299.5275354348605;4940.777665005084;4946.554810067039;4947.65366424354;4958.454569997298;4979.775910084055;4471.128130014616;4509.594136527729;4527.932081018787;4553.612942899825;4587.61005314552;5992.0712289595185;6034.668093254913;6064.120702498113;6070.3019152797115;6076.726547305382;6223.315435302113;6238.344973777688;6319.58922670025;6337.524685648595;6353.7140828661895;6071.635701857903;6076.0278355462915;6077.118817771398;6094;6123.938760612336;5520.365158006881;5533.446655334435;5536.833894983157;5546.473085056913;5549.889002219933;5506.201600767947;6305.054241863757;6428.100065990671;6480.513961452815;6491.285958544557;6292.2134733158355;6325.367463253822;6337.524685648503;6343.651099189589;6349.746010159542;6531.020346947996;6539.411452969255;6540.37866402691;6541.280459149394;6573.605583664996;5412.431694672003;6128.417800308964;6213.099100630293;6288.654124023223;6311;6295.96852015737;6302.180716506825;6306.180196574416;6321.778737744157;6323.114763932961;6099.634021958696;6324.747010119728;6325.8734825304155;6338.841528961812;6348.5238607105575;6114.60152118864;6217.875642487215;6270.686465676789;6277.466415354564;6332.176817013758;6116.816495505142;6148.754049837957;6155.47678447337;6160.199174107337;6161.229846269216;6109.890546867989;6311.463525600376;6324.2410910691015;6336.176297081534;6345.333739957238;6059.787907423219;6084.513238940963;6112.520519325332;6137.346341658241;6202.875942481215 11:03:34 INFO - PROCESS | 1936 | |1;ext.html;495.9782847334489;594.6640148316201;606.1150719948874;661.8940969444886;662.8574856405874;31852.84073579632;32279.838600806994;32326.030219093464;32409.51385729213;32480.675193248062;34464.31071378571;42951.14097718044;43475;43484.6954591362;43524;9712.85430718538;9899.50502474877;9910.067536830285;9912.405255684645;9930.751731206705;9808.803823923517;9960.20318374532;9966.252531060163;9968.152707019875;9976.551055202533;9903.059209375098;9988.600455981752;9993.150582200486;9996.450195239258;10008.99910008997;9904.801903961916;10092.293539452277;10095.697129086066;10100;10136.341137826092;9762.951185244028;9879.506024698736;9891.505424728806;9897.901020989842;9901.405915645013;44101;44448.77775611101;44455.55544444547;44508;44700.55299446997;3293.5883014623173;3490.040238934288;3689.6494832991093;3735.252949410102;3994.021464741157;29855.785510826114;30842.69157308443;31042.379152417052;31364.529532057037;31387.058388248162;2830.844303563303;2835.53213719736;2856.685764565896;2883.7692984561186;2938.030449951511;471253;472465;472567;472730;474054;72694.63652681703;73262.26737732554;73440.63279683568;73533;73569.6321518389;81612;82804.58597707094;82948.17051829526;83065.75401368985;83227;18969.62060758777;19013.239470421027;19184.944828034313;19234.422967311002;19285.42143735662;14536.854631453762;14596;14599.92700036493;14606.63483412902;14612.196329201783;23662.29013129609;23961.400964976016;23976.760232397453;24132.63801042986;24148.758512415003;8949.552522373855;9123.635054597742;9132.634694612274;9134.132257435533;9136.71582104474;937.7843096087802;1016.9186465082776;1033.3438266700548;1049.9790004199874;1129.1192869561755;27852.30369240785;30973.225669357995;31153.688463115534;31207.043397310037;31574.29347799091;1001.4341896828269;1110.5280255891214;1132.4620805117504;1232.3222227774688;1240.8770063092916;13389.799153012713;15746.76379854303;15990.120543370227;16035.679286414206;16282.75575866363;542131;546105;546669;547257;547689;65331;65595.67202164054;65720;65977;66013.6797264052;1421.6303761022002;1530.900491468051;1540.353051718281;1564.5619226616566;1567.7099736548776;26350.868245659414;30011.99052649298;31598;31866.7253309865;31974.68025319717;53700.73149634383;53979.190312144565;54243.72878135584;54293;54421.45578544322;369352;374680;376429;376842;377707.2229277782;30850.845745771127;36424.45363319499;36869;48784.75607621939;49563.25655115104;49161.508384915694;49713;50736.74631626818;51110.74444627753;52658;40141.1971760569;41368.1726365477;41371.379429307985;41601;42897.35653965131;35872.10319741923;36768.44847327239;40546.59453405428;40552.59447405488;41622;40950.38574421446;41223.96940076522;41809.372859406525;42165.367519486615;42727.14545709006;34118.14704632404;34671;36168.09579760527;36349;36611.450828237066;26718.732812671624;26872.731272687022;26935.73064269332;26956.86521567458;27526.724732752416 11:03:34 INFO - PROCESS | 1936 | |2;jquery.html;372.69066674660024;377.0441929708192;378.08880597759395;384.2161989541336;384.87491565241305;20758.792412075876;21285.680714789272;21906;22190.334289971288;22233.888830555843;12265.693357666063;12901.22592644442;12910.870891291084;12921.483140674385;12938.870611293883;6435.131257280254;6802.557833740816;6803.421709154728;6811.761588344409;6815.591064536144;4425.911481770363;4936.35827342445;5688.687122208277;6829;7499.437542184358;7608.771736847876;7686.53880767153;7701.576413297266;7731.45879788415;7731.806704832368;7435.479516433852;7638.54168749874;7684.654190561439;7722.806929826771;7730.7680769577;3859.4403811447464;6994.33553812387;7278.672459739271;7284.635768211621;7294.416446684252;28823;29431.11706648804;29813.10560683183;29982.85008574965;31235.687643123507;2458.950820983588;2487.216526794054;2505.3987043109705;2567.7817385522253;2626.1071235779737;11767.117466189984;15340.309686064042;15961.92019039909;16914.577135571588;17264.48206553793;1919.9616007679767;1957.4323446200585;1988.6221617892554;2030.9845077461268;2070.6023434182016;115710;124097;125330.3733481336;126326;127762.3611881944;19912.203511859363;19975.800241997393;20545.383638490868;20624.48438789042;20626.58746825085;31117.599708013193;31247.843760781052;31354.52968205479;31776.523352149736;31865.362692746014;11461.255018423775;11804.232724872856;11827.822582661267;11829.52681892732;11938.76122477563;8086.474379165335;10011.948745381776;10055.195584353234;10085.899141008496;10168.898311016943;7358.632068396559;8556.828863422821;8917.152870477294;8966;9025.32310076747;2923.348308205857;3394.9490757638655;3493.7205023598053;3532.322146980164;3654.8903532893523;879.846026945282;912.762681702762;977.9315447918719;996.7408473796866;1023.6110278094277;20468.79531204669;21264.78735212659;21273.893630531747;21345.46636334073;21986.560268794536;1014.7361685961703;1026.5688410867454;1057.9047885690325;1078.5362294213407;1092.1917780842277;11308.982191602796;11763.176577639482;11783.52865885355;11808;11961.282323060645;664321;666831;669583;696178;697250;121782.391088044;124327;125424;126684.36657816652;130420;1031.8142734307746;1039.0856046678873;1044.796264728386;1054.2116102907767;1064.9041586257274;18768.62462750765;18890.43328700141;19315.51711207231;19716.802831971498;19731.309404170785;53369.733151333996;53855.73072134614;55447.722761385936;56171.71914140403;57086.429135709775;71904;75502;81341;81784.77322840043;86363.36491758889;8188.385871059813;8516.063233044237;8564.443311184754;8601;8867.201951824367;12185.207961482476;12870.485180592672;13257.66855828612;13800.792988104986;14130.858691412954;11622.82565761531;11740.236884602473;11902.523899043941;11991;11993.520259189883;11336;11345.37600431951;11496.137789665641;11665.24175928562;11727.061835053346;11943.701407464883;12013.519459221883;12136.332501712137;12201.938990304992;12307.87692123103;8415.200555947175;8419.452735572413;8522.446041007315;8581.8712719308;8741.169588889044;11207.551697931991;11840.585579504675;12004.39978001114;12119.212251203997;12119.454624542093 11:03:34 INFO - PROCESS | 1936 | |3;mootools.html;1506.224294488338;1635.3785561486636;1667.9332826686932;1965.6461836869366;2039.7756246812858;8390.496570205793;9085.636574537019;9301.395409298408;9307.115823996717;9321.300902432311;8962.327825413087;9012.279017678586;9113.726588202348;9122.361434699573;9137.22333601643;2588.7670109690075;2610.973890261092;2612.4905643399543;2614.398688301692;2616.4636249568794;2549.7067837198683;2619.109502769058;2620;2621.3577673470027;2637.1297471834346;2602.882870270833;2612.8171028028046;2615.986920065397;2617.8429294242405;2627.8029147813895;2577.7293384194672;2583.677040369954;2629.368951451657;2632.0787724296533;2636.1037247336;2580.8580528070947;2598.986395305832;2611.2949503634104;2631.2369412870244;2634.894604215829;9215;9282.164605185499;9287.931887832918;9289.53552322388;9297.163255307054;5405.5135037846385;5575.219469274305;5596.4403559644115;5599.944000559983;5607.186957891083;3651.6165802590613;3722.8883133506038;3793.165503589206;3808.447775072627;3816.084139806454;1078.1267173589417;1087.3638921231088;1089.1667874076338;1109.8557187565564;1130.4347826086957;11992.280463172237;12005.459754311078;12016.158868879182;12039.09706771987;12057.397130143458;4941.530554597308;4955.380577427822;4991.001799640087;5040.31955685985;5074.061298659686;8622.267107295826;10233;10238.846417303746;10245.48772561369;10259.640912568024;5646.604737668324;5671.234383358276;5675.091985282335;5681.4034526374135;5686.3744988051285;3795.3358162321483;4761.809527618856;4996.800127994912;5191.273221748958;5258.710770907637;4085.565996663867;4123.340265557496;4148.43996060534;4182.811773470201;4188.8324467020975;1320.650027742649;1349.379285528648;1351.6080336702246;1358.802973568827;1363.7340718559785;1415.6531649745878;1418.1349376880096;1442.451868290043;1450.4415799917108;1458.2417143085536;8584.05575386707;8593.65625374978;8630.136986301446;8636.654533818577;8652.307815374756;537.2076187623303;544.6895269696236;548.832606055149;552.3316786688152;552.6076485695121;6392.296847346788;6413.518986076063;6425.421712045845;6457;6464.903026454607;10919.290246133976;11464.31214127155;11470.942645286721;11480.368579728196;11493.425328733698;10554.630587929385;11071.114310855111;11150.163737719704;11282.435878206057;11317.717057073474;8697.95651021741;8798.340124490689;8820.470771753715;8861.955690221508;8871.822563548692;8471.788205294917;8480.236778689701;8526.48841069513;8624;8640.56797160152;9945.850812237966;9973.055254225357;10015.098641122335;10129;10277.177825773771;10153.64462243818;10530.894691052992;10740.731481712706;10776.461176941279;10990.340579565252;7145.285471452813;7333.596652183967;7335.963320183365;7744.651490683045;8005.879911801211;8077.87883181741;8149.470284431493;8448.028476725009;8691;8691.435056721293;7503.5497870127965;7591.506552074097;7655.655495502604;7673.462857599914;7704.075510938723;7443.665035073326;7501.9744668940175;7514.62426878643;7600.50596711212;7637.274458926393;7989.800254993672;8027.919720802717;8050.154733752872;8055.436119471581;8097.676092956216;7334.853302933805;7362.300581444754;7404.851902962018;7413.369863561657;7451.813704657427;7488.026556547614;7492.100947886289;7543.283388078124;7546.66040028189;7551.018367612175 11:03:34 INFO - PROCESS | 1936 | |4;prototype.html;316.49361022364207;333.11723931581304;335.43646673588364;343.30309471772296;343.6408952644486;5218.373795144578;6535.215774107108;6538;6586.077949087132;6592.901106483395;6479.222493300798;6486.513511486645;6514.446272066868;6519.576227545218;6529.608223506593;4685.672002959795;4797;4811.398575178103;4896;4951.356323677916;4887.535684110004;4896.338994235786;4915.943072239468;4943.678660887049;4948.15881300178;4881.902361952759;4889.584385327234;4889.706617602955;4901.901961960759;4905.460399356068;3762.473253744478;4742.099001189763;4883.755812209375;4886.584640305578;4892.290617860391;4188.643965262956;4199.118185181115;4206.41110244566;4212.7682977436225;4218.987443013685;6288.213973253343;6303.936960630381;6314.273858506284;6324.525660575475;6327.4938004959495;4664.55686709762;5756.712164391805;5756.942430575683;5760;5766.192733017381;5578.693171875545;6964.408025317804;6966.268541803089;6966.686499107502;6972.860542789116;3882.3011857865854;4596.701214421086;4781.258904869751;4782.832600858988;4787.353707249512;7140.678669459887;7301.269873012656;7301.926980730178;7311.268873112699;7311.670974806147;4849.321095046696;4857.368542089576;4883.902321953612;4890.046440943982;4892.657513974059;4943.307936888838;4954.1825598775795;4956.182229932021;4956.900861982812;4966.279889416014;5783.537317014629;5792.189093526909;5795.362510123883;5805.867855768169;5806.506446951972;5618.943810561842;6727.428168605626;6967.756128535579;6985.720571177096;6997.230304666483;1688.5187721499315;1703.582622257555;1713.4345665930214;1716.7339062445342;1721.5437908954136;1043.1289872956168;1052.8262836632023;1103.426218366445;1108.9112870970303;1141.3779490177874;5358.30342055538;5823.184754134425;6675.7997260082275;6710.060591517192;6713.160854893138;7228.927710722931;7254.165770936304;7258.383037441877;7277.745278915212;7280.580286844014;5497.642653227527;6648.301928297556;6686.398224159849;6687.565308254948;6812.386885180357;3799.1831756172555;3838.808059597009;3843.5964223756664;3843.5964223756664;3849.4610754494392;7395.963020184865;7643.617819109022;7646.9617651912495;7651.885221721679;7665.578393188428;7473.252674732592;7495.8500829983095;7502.324790768748;7506.24937506245;7514.0607424071995;7579.810504737426;7591.734289299848;7607.315341619281;7619.771406857803;7626.733064342721;5894.70526473666;6982.476314276348;7261.4190864729635;7269;7278.96360518194;5982.252218472691;6960.338767817049;7122.145342558926;7138.535995160298;7150.606716630636;6111.663858487826;7606.04924384452;7608.934749135236;7626.351760100453;7629.580373079534;4616.607588354893;4663.626909847272;4671.719696818202;4677.555632214934;4682.531746825291;7009.1589009319205;7237.986681864438;7261.128664560287;7263.16473605521;7277.854442911218;6928.584284942919;7007.544509606859;7033.683484243119;7042.753503627348;7057.082579264663;6353.555251132377;6379.106925030406;6948.687309071003;7002.124734408199;7008.5094043416475;6822.181338239443;6828.146481689789;6833.521653484408;6836.623985680835;6838.076859623887;6753.729850806109;7016.964915175391;7019.578825270296;7026.437884969292;7033.331833475811;6644.169478815148;6799.6600169990315;6819.113515242987;6875;6876.312368763083 11:03:34 INFO - PROCESS | 1936 | |5;yui.html;644.6100109433793;725.6190499987506;756.3306473770715;756.965936532856;786.1313248860008;15387.461438849628;15576.68846623067;15611.92194039031;15613.375464981402;15643.530694079182;14315.713685726305;14355.92822035891;14377;14382.208978506178;14414.49549265776;790.1703211627782;809.7854068671777;961.3414810854553;986.4032260482412;994.4282037828242;962.5283611030579;971.0241207586366;974.2985050763474;974.7465658928694;975.9902400976006;1052.8736551613817;1055.3456856748787;1057.1701214546583;1058.6083149234794;1059.2532264753331;845.2899564365931;1024.9948750256237;1048.192891473565;1049.3651340938775;1050.5902697947806;787.2049230277404;787.6180052674448;788.1448628238368;788.3141666749907;791.6477167660394;15176.241187940559;15215.239238038053;15246.695066098728;15280.847191528164;15283.847161528354;12865.163764355288;13255.60233192996;13370.866291337157;13430.798538021938;13504.189748615114;10239.080848187918;10291.588336466531;10452.686419407353;10606.204534659853;11009.61466348674;3538.274653695986;3543.1496440854266;3628.219932714479;3672.265546890633;3677.8161091945294;79514.60242698807;80795;81168.59415702942;81176.18823811745;81439.778403324;9593.472359020181;9784.902150978542;9822.901770982198;10121.1903047756;10140.645077422403;21946.45133871666;21970.780292197192;21982.780172198072;22020.33938981833;22087.779122208573;6723.327667233335;7516;7682.692692292246;7721.420893432903;7793.7272195474025;4139.875803725893;4225.3239481683395;4287.6998610097;4304.74171549708;4421.668374871898;3680.8895733128047;3741.382671859167;3754.887353379403;3757.4739536464917;3760.623937606272;556.4546744190716;580.8818025301279;648.7664440801308;653.1737352249409;671.8320419895026;398.8105649816372;429.83552615326875;474.10157751062235;486.75175660412737;496.81866118866355;7888.684452621946;7992.800179995546;8018.599070046591;8028.799280017929;8263.173682631688;512.4619149892673;515.5128403658507;548.6488647265753;566.1846940405802;574.3452464190826;3617.8371973261264;3762.8682996095004;3792.7724336539345;3877.127646279621;3935.980320098381;95117;97896;98868.51697224547;99146;99594;81244.59377703074;81588.77616835752;81673;81805;82244.58877705692;71104.64447677729;73468;74828.62585687036;75296.4940701183;75863.62068189624;7609.505382150142;7652.923470765221;7809.062912450542;7922;8124.55314957683;51226.206725400174;52699.209511856585;53344;53914.73042634762;54464.18303725368;67048.6647566759;68580.6570967162;73402.26597734168;73452.26547734668;73655.52688946298;9915.504224788587;9916.256280779115;9930.354526955725;10017;10058.8491172631;10286.485675716334;10674;10689.89310106889;10850.29473084247;10941.781164376827;9811;10128.34165779222;10347.379157250589;10392.42841643717;10785.137189025016;11402.372869492257;11480.712982175512;11571.479283432434;11675.649730508097;11815.881841181477;11091.778164436828;11229.71925701864;11268.742618809261;11427.828582571101;11758.235714678518;9712.368696034735;9760.85358719634;9841.507924603598;9887.505624718879;10241;9551.331406801457;9703.6118555257;9709;9756.951215243878;9926.15627671656 11:03:34 INFO - PROCESS | 1936 | __end_tp_report 11:03:34 INFO - PROCESS | 1936 | __start_cc_report 11:03:34 INFO - PROCESS | 1936 | _x_x_mozilla_cycle_collect,1173 11:03:34 INFO - PROCESS | 1936 | __end_cc_report 11:03:34 INFO - PROCESS | 1936 | __startTimestamp1463162614566__endTimestamp 11:03:34 INFO - PROCESS | 1936 | 11:03:34 INFO - PROCESS | 1936 | ------- Summary: start ------- 11:03:34 INFO - PROCESS | 1936 | Number of tests: 6 11:03:34 INFO - PROCESS | 1936 | 11:03:34 INFO - PROCESS | 1936 | [#0] dojo.html Cycles:165 Average:5853.18 Median:6094.00 stddev:642.37 (10.5%) stddev-sans-first:606.52 11:03:34 INFO - PROCESS | 1936 | Values: 3084.7 3306.5 3632.0 3653.7 3663.3 5848.1 5866.5 5893.1 5917.9 5921.7 5881.1 5889.9 5918.2 5923.0 5952.7 5246.7 5278.3 5309.7 5315.3 5369.8 5405.1 5415.4 5420.3 5425.1 5427.0 5335.7 5383.7 5388.5 5401.6 5407.0 5399.0 5410.3 5423.8 5433.5 5475.6 5060.6 5345.0 5358.5 5367.3 5372.0 5696.0 5750.9 5758.0 5781.3 5799.1 6276.7 6314.2 6314.4 6323.7 6323.7 5268.8 6241.6 6300.3 6304.4 6348.1 6035.5 6072.9 6074.2 6077.0 6086.1 5378.5 6238.9 6338.2 6407.7 6427.8 6212.5 6238.5 6250.1 6278.5 6355.1 5519.7 6164.8 6314.4 6343.9 6350.1 6266.2 6277.6 6303.7 6317.6 6327.4 5027.3 5776.1 6246.1 6272.6 6299.5 4940.8 4946.6 4947.7 4958.5 4979.8 4471.1 4509.6 4527.9 4553.6 4587.6 5992.1 6034.7 6064.1 6070.3 6076.7 6223.3 6238.3 6319.6 6337.5 6353.7 6071.6 6076.0 6077.1 6094.0 6123.9 5520.4 5533.4 5536.8 5546.5 5549.9 5506.2 6305.1 6428.1 6480.5 6491.3 6292.2 6325.4 6337.5 6343.7 6349.7 6531.0 6539.4 6540.4 6541.3 6573.6 5412.4 6128.4 6213.1 6288.7 6311.0 6296.0 6302.2 6306.2 6321.8 6323.1 6099.6 6324.7 6325.9 6338.8 6348.5 6114.6 6217.9 6270.7 6277.5 6332.2 6116.8 6148.8 6155.5 6160.2 6161.2 6109.9 6311.5 6324.2 6336.2 6345.3 6059.8 6084.5 6112.5 6137.3 6202.9 11:03:34 INFO - PROCESS | 1936 | 11:03:34 INFO - PROCESS | 1936 | [#1] ext.html Cycles:180 Average:63846.77 Median:40343.90 stddev:124581.71 (308.8%) stddev-sans-first:124840.39 11:03:34 INFO - PROCESS | 1936 | Values: 496.0 594.7 606.1 661.9 662.9 31852.8 32279.8 32326.0 32409.5 32480.7 34464.3 42951.1 43475.0 43484.7 43524.0 9712.9 9899.5 9910.1 9912.4 9930.8 9808.8 9960.2 9966.3 9968.2 9976.6 9903.1 9988.6 9993.2 9996.5 10009.0 9904.8 10092.3 10095.7 10100.0 10136.3 9763.0 9879.5 9891.5 9897.9 9901.4 44101.0 44448.8 44455.6 44508.0 44700.6 3293.6 3490.0 3689.6 3735.3 3994.0 29855.8 30842.7 31042.4 31364.5 31387.1 2830.8 2835.5 2856.7 2883.8 2938.0 471253.0 472465.0 472567.0 472730.0 474054.0 72694.6 73262.3 73440.6 73533.0 73569.6 81612.0 82804.6 82948.2 83065.8 83227.0 18969.6 19013.2 19184.9 19234.4 19285.4 14536.9 14596.0 14599.9 14606.6 14612.2 23662.3 23961.4 23976.8 24132.6 24148.8 8949.6 9123.6 9132.6 9134.1 9136.7 937.8 1016.9 1033.3 1050.0 1129.1 27852.3 30973.2 31153.7 31207.0 31574.3 1001.4 1110.5 1132.5 1232.3 1240.9 13389.8 15746.8 15990.1 16035.7 16282.8 542131.0 546105.0 546669.0 547257.0 547689.0 65331.0 65595.7 65720.0 65977.0 66013.7 1421.6 1530.9 1540.4 1564.6 1567.7 26350.9 30012.0 31598.0 31866.7 31974.7 53700.7 53979.2 54243.7 54293.0 54421.5 369352.0 374680.0 376429.0 376842.0 377707.2 30850.8 36424.5 36869.0 48784.8 49563.3 49161.5 49713.0 50736.7 51110.7 52658.0 40141.2 41368.2 41371.4 41601.0 42897.4 35872.1 36768.4 40546.6 40552.6 41622.0 40950.4 41224.0 41809.4 42165.4 42727.1 34118.1 34671.0 36168.1 36349.0 36611.5 26718.7 26872.7 26935.7 26956.9 27526.7 11:03:34 INFO - PROCESS | 1936 | 11:03:34 INFO - PROCESS | 1936 | [#2] jquery.html Cycles:180 Average:38899.12 Median:21625.73 stddev:112450.49 (520.0%) stddev-sans-first:112728.74 11:03:34 INFO - PROCESS | 1936 | Values: 372.7 377.0 378.1 384.2 384.9 20758.8 21285.7 21906.0 22190.3 22233.9 12265.7 12901.2 12910.9 12921.5 12938.9 6435.1 6802.6 6803.4 6811.8 6815.6 4425.9 4936.4 5688.7 6829.0 7499.4 7608.8 7686.5 7701.6 7731.5 7731.8 7435.5 7638.5 7684.7 7722.8 7730.8 3859.4 6994.3 7278.7 7284.6 7294.4 28823.0 29431.1 29813.1 29982.9 31235.7 2459.0 2487.2 2505.4 2567.8 2626.1 11767.1 15340.3 15961.9 16914.6 17264.5 1920.0 1957.4 1988.6 2031.0 2070.6 115710.0 124097.0 125330.4 126326.0 127762.4 19912.2 19975.8 20545.4 20624.5 20626.6 31117.6 31247.8 31354.5 31776.5 31865.4 11461.3 11804.2 11827.8 11829.5 11938.8 8086.5 10011.9 10055.2 10085.9 10168.9 7358.6 8556.8 8917.2 8966.0 9025.3 2923.3 3394.9 3493.7 3532.3 3654.9 879.8 912.8 977.9 996.7 1023.6 20468.8 21264.8 21273.9 21345.5 21986.6 1014.7 1026.6 1057.9 1078.5 1092.2 11309.0 11763.2 11783.5 11808.0 11961.3 664321.0 666831.0 669583.0 696178.0 697250.0 121782.4 124327.0 125424.0 126684.4 130420.0 1031.8 1039.1 1044.8 1054.2 1064.9 18768.6 18890.4 19315.5 19716.8 19731.3 53369.7 53855.7 55447.7 56171.7 57086.4 71904.0 75502.0 81341.0 81784.8 86363.4 8188.4 8516.1 8564.4 8601.0 8867.2 12185.2 12870.5 13257.7 13800.8 14130.9 11622.8 11740.2 11902.5 11991.0 11993.5 11336.0 11345.4 11496.1 11665.2 11727.1 11943.7 12013.5 12136.3 12201.9 12307.9 8415.2 8419.5 8522.4 8581.9 8741.2 11207.6 11840.6 12004.4 12119.2 12119.5 11:03:34 INFO - PROCESS | 1936 | 11:03:34 INFO - PROCESS | 1936 | [#3] mootools.html Cycles:180 Average:6310.03 Median:5224.99 stddev:3332.19 (63.8%) stddev-sans-first:3321.97 11:03:34 INFO - PROCESS | 1936 | Values: 1506.2 1635.4 1667.9 1965.6 2039.8 8390.5 9085.6 9301.4 9307.1 9321.3 8962.3 9012.3 9113.7 9122.4 9137.2 2588.8 2611.0 2612.5 2614.4 2616.5 2549.7 2619.1 2620.0 2621.4 2637.1 2602.9 2612.8 2616.0 2617.8 2627.8 2577.7 2583.7 2629.4 2632.1 2636.1 2580.9 2599.0 2611.3 2631.2 2634.9 9215.0 9282.2 9287.9 9289.5 9297.2 5405.5 5575.2 5596.4 5599.9 5607.2 3651.6 3722.9 3793.2 3808.4 3816.1 1078.1 1087.4 1089.2 1109.9 1130.4 11992.3 12005.5 12016.2 12039.1 12057.4 4941.5 4955.4 4991.0 5040.3 5074.1 8622.3 10233.0 10238.8 10245.5 10259.6 5646.6 5671.2 5675.1 5681.4 5686.4 3795.3 4761.8 4996.8 5191.3 5258.7 4085.6 4123.3 4148.4 4182.8 4188.8 1320.7 1349.4 1351.6 1358.8 1363.7 1415.7 1418.1 1442.5 1450.4 1458.2 8584.1 8593.7 8630.1 8636.7 8652.3 537.2 544.7 548.8 552.3 552.6 6392.3 6413.5 6425.4 6457.0 6464.9 10919.3 11464.3 11470.9 11480.4 11493.4 10554.6 11071.1 11150.2 11282.4 11317.7 8698.0 8798.3 8820.5 8862.0 8871.8 8471.8 8480.2 8526.5 8624.0 8640.6 9945.9 9973.1 10015.1 10129.0 10277.2 10153.6 10530.9 10740.7 10776.5 10990.3 7145.3 7333.6 7336.0 7744.7 8005.9 8077.9 8149.5 8448.0 8691.0 8691.4 7503.5 7591.5 7655.7 7673.5 7704.1 7443.7 7502.0 7514.6 7600.5 7637.3 7989.8 8027.9 8050.2 8055.4 8097.7 7334.9 7362.3 7404.9 7413.4 7451.8 7488.0 7492.1 7543.3 7546.7 7551.0 11:03:34 INFO - PROCESS | 1936 | 11:03:34 INFO - PROCESS | 1936 | [#4] prototype.html Cycles:180 Average:5720.98 Median:6429.16 stddev:1797.51 (28.0%) stddev-sans-first:1756.18 11:03:34 INFO - PROCESS | 1936 | Values: 316.5 333.1 335.4 343.3 343.6 5218.4 6535.2 6538.0 6586.1 6592.9 6479.2 6486.5 6514.4 6519.6 6529.6 4685.7 4797.0 4811.4 4896.0 4951.4 4887.5 4896.3 4915.9 4943.7 4948.2 4881.9 4889.6 4889.7 4901.9 4905.5 3762.5 4742.1 4883.8 4886.6 4892.3 4188.6 4199.1 4206.4 4212.8 4219.0 6288.2 6303.9 6314.3 6324.5 6327.5 4664.6 5756.7 5756.9 5760.0 5766.2 5578.7 6964.4 6966.3 6966.7 6972.9 3882.3 4596.7 4781.3 4782.8 4787.4 7140.7 7301.3 7301.9 7311.3 7311.7 4849.3 4857.4 4883.9 4890.0 4892.7 4943.3 4954.2 4956.2 4956.9 4966.3 5783.5 5792.2 5795.4 5805.9 5806.5 5618.9 6727.4 6967.8 6985.7 6997.2 1688.5 1703.6 1713.4 1716.7 1721.5 1043.1 1052.8 1103.4 1108.9 1141.4 5358.3 5823.2 6675.8 6710.1 6713.2 7228.9 7254.2 7258.4 7277.7 7280.6 5497.6 6648.3 6686.4 6687.6 6812.4 3799.2 3838.8 3843.6 3843.6 3849.5 7396.0 7643.6 7647.0 7651.9 7665.6 7473.3 7495.9 7502.3 7506.2 7514.1 7579.8 7591.7 7607.3 7619.8 7626.7 5894.7 6982.5 7261.4 7269.0 7279.0 5982.3 6960.3 7122.1 7138.5 7150.6 6111.7 7606.0 7608.9 7626.4 7629.6 4616.6 4663.6 4671.7 4677.6 4682.5 7009.2 7238.0 7261.1 7263.2 7277.9 6928.6 7007.5 7033.7 7042.8 7057.1 6353.6 6379.1 6948.7 7002.1 7008.5 6822.2 6828.1 6833.5 6836.6 6838.1 6753.7 7017.0 7019.6 7026.4 7033.3 6644.2 6799.7 6819.1 6875.0 6876.3 11:03:34 INFO - PROCESS | 1936 | 11:03:34 INFO - PROCESS | 1936 | [#5] yui.html Cycles:180 Average:18871.41 Median:26607.36 stddev:26945.98 (101.3%) stddev-sans-first:26986.81 11:03:34 INFO - PROCESS | 1936 | Values: 644.6 725.6 756.3 757.0 786.1 15387.5 15576.7 15611.9 15613.4 15643.5 14315.7 14355.9 14377.0 14382.2 14414.5 790.2 809.8 961.3 986.4 994.4 962.5 971.0 974.3 974.7 976.0 1052.9 1055.3 1057.2 1058.6 1059.3 845.3 1025.0 1048.2 1049.4 1050.6 787.2 787.6 788.1 788.3 791.6 15176.2 15215.2 15246.7 15280.8 15283.8 12865.2 13255.6 13370.9 13430.8 13504.2 10239.1 10291.6 10452.7 10606.2 11009.6 3538.3 3543.1 3628.2 3672.3 3677.8 79514.6 80795.0 81168.6 81176.2 81439.8 9593.5 9784.9 9822.9 10121.2 10140.6 21946.5 21970.8 21982.8 22020.3 22087.8 6723.3 7516.0 7682.7 7721.4 7793.7 4139.9 4225.3 4287.7 4304.7 4421.7 3680.9 3741.4 3754.9 3757.5 3760.6 556.5 580.9 648.8 653.2 671.8 398.8 429.8 474.1 486.8 496.8 7888.7 7992.8 8018.6 8028.8 8263.2 512.5 515.5 548.6 566.2 574.3 3617.8 3762.9 3792.8 3877.1 3936.0 95117.0 97896.0 98868.5 99146.0 99594.0 81244.6 81588.8 81673.0 81805.0 82244.6 71104.6 73468.0 74828.6 75296.5 75863.6 7609.5 7652.9 7809.1 7922.0 8124.6 51226.2 52699.2 53344.0 53914.7 54464.2 67048.7 68580.7 73402.3 73452.3 73655.5 9915.5 9916.3 9930.4 10017.0 10058.8 10286.5 10674.0 10689.9 10850.3 10941.8 9811.0 10128.3 10347.4 10392.4 10785.1 11402.4 11480.7 11571.5 11675.6 11815.9 11091.8 11229.7 11268.7 11427.8 11758.2 9712.4 9760.9 9841.5 9887.5 10241.0 9551.3 9703.6 9709.0 9757.0 9926.2 11:03:34 INFO - PROCESS | 1936 | -------- Summary: end -------- 11:03:34 INFO - PROCESS | 1936 | 11:03:35 INFO - TEST-INFO | 1936: exit 0 11:03:35 INFO - TEST-OK | dromaeo_css | took 1112170ms 11:03:35 INFO - TEST-START | kraken 11:03:35 INFO - operating with platform_type : mac_ 11:03:35 INFO - Initialising browser for kraken test... 11:03:35 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmppOSVAu/profile http://localhost:49749/getInfo.html) 11:03:37 INFO - PROCESS | 1944 | __metrics Screen width/height:1600/1200 11:03:37 INFO - PROCESS | 1944 | colorDepth:24 11:03:37 INFO - PROCESS | 1944 | Browser inner width/height: 1024/689 11:03:37 INFO - PROCESS | 1944 | __metrics 11:03:37 INFO - PROCESS | 1944 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:03:37 INFO - PROCESS | 1944 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:03:37 INFO - TEST-INFO | 1944: exit 0 11:03:37 INFO - Browser initialized. 11:03:37 INFO - Running cycle 1/1 for kraken test... 11:03:37 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmppOSVAu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:03:49 INFO - PROCESS | 1947 | RSS: Main: 156811264 11:03:49 INFO - PROCESS | 1947 | 11:03:52 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49749/tests/kraken/driver.html?testName=audio-beat-detection) 11:03:52 INFO - PROCESS | 1947 | RSS: Main: 213291008 11:03:52 INFO - PROCESS | 1947 | 11:03:55 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49749/tests/kraken/driver.html?testName=audio-dft) 11:03:56 INFO - PROCESS | 1947 | RSS: Main: 225296384 11:03:56 INFO - PROCESS | 1947 | 11:03:59 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49749/tests/kraken/driver.html?testName=audio-fft) 11:03:59 INFO - PROCESS | 1947 | RSS: Main: 214908928 11:03:59 INFO - PROCESS | 1947 | 11:04:01 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49749/tests/kraken/driver.html?testName=audio-oscillator) 11:04:02 INFO - PROCESS | 1947 | RSS: Main: 216899584 11:04:02 INFO - PROCESS | 1947 | 11:04:04 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49749/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:04:04 INFO - PROCESS | 1947 | RSS: Main: 216977408 11:04:04 INFO - PROCESS | 1947 | 11:04:07 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49749/tests/kraken/driver.html?testName=imaging-darkroom) 11:04:08 INFO - PROCESS | 1947 | RSS: Main: 216821760 11:04:08 INFO - PROCESS | 1947 | 11:04:11 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49749/tests/kraken/driver.html?testName=imaging-desaturate) 11:04:11 INFO - PROCESS | 1947 | RSS: Main: 216911872 11:04:11 INFO - PROCESS | 1947 | 11:04:14 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49749/tests/kraken/driver.html?testName=json-parse-financial) 11:04:15 INFO - PROCESS | 1947 | RSS: Main: 217202688 11:04:15 INFO - PROCESS | 1947 | 11:04:16 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49749/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:04:17 INFO - PROCESS | 1947 | RSS: Main: 250007552 11:04:17 INFO - PROCESS | 1947 | 11:04:18 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:04:19 INFO - PROCESS | 1947 | RSS: Main: 250982400 11:04:19 INFO - PROCESS | 1947 | 11:04:21 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:04:22 INFO - PROCESS | 1947 | RSS: Main: 255987712 11:04:22 INFO - PROCESS | 1947 | 11:04:24 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:04:25 INFO - PROCESS | 1947 | RSS: Main: 257982464 11:04:25 INFO - PROCESS | 1947 | 11:04:28 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:04:28 INFO - PROCESS | 1947 | RSS: Main: 257998848 11:04:28 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49749/tests/kraken/driver.html?testName=ai-astar) 11:04:30 INFO - PROCESS | 1947 | RSS: Main: 320339968 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | __start_tp_report 11:04:30 INFO - PROCESS | 1947 | _x_x_mozilla_page_load 11:04:30 INFO - PROCESS | 1947 | _x_x_mozilla_page_load_details 11:04:30 INFO - PROCESS | 1947 | |i|pagename|runs| 11:04:30 INFO - PROCESS | 1947 | |0;ai-astar;110;107;112;104;110;111;119;111;108;109 11:04:30 INFO - PROCESS | 1947 | |1;audio-beat-detection;149;120;153;151;119;160;143;184;146;126 11:04:30 INFO - PROCESS | 1947 | |2;audio-dft;183;185;185;185;184;183;185;184;187;182 11:04:30 INFO - PROCESS | 1947 | |3;audio-fft;78;72;72;119;55;58;58;58;118;56 11:04:30 INFO - PROCESS | 1947 | |4;audio-oscillator;90;92;128;81;77;82;117;77;79;115 11:04:30 INFO - PROCESS | 1947 | |5;imaging-gaussian-blur;87;84;88;84;86;83;89;84;87;84 11:04:30 INFO - PROCESS | 1947 | |6;imaging-darkroom;92;92;93;93;116;87;131;150;94;93 11:04:30 INFO - PROCESS | 1947 | |7;imaging-desaturate;84;87;84;84;86;84;96;142;135;87 11:04:30 INFO - PROCESS | 1947 | |8;json-parse-financial;53;58;57;56;57;57;57;57;53;51 11:04:30 INFO - PROCESS | 1947 | |9;json-stringify-tinderbox;64;62;70;71;71;69;66;67;67;67 11:04:30 INFO - PROCESS | 1947 | |10;stanford-crypto-aes;80;69;78;93;107;105;108;79;79;84 11:04:30 INFO - PROCESS | 1947 | |11;stanford-crypto-ccm;118;128;118;117;118;121;115;107;138;146 11:04:30 INFO - PROCESS | 1947 | |12;stanford-crypto-pbkdf2;132;122;146;133;161;163;172;130;133;134 11:04:30 INFO - PROCESS | 1947 | |13;stanford-crypto-sha256-iterative;66;66;64;65;65;66;67;65;66;64 11:04:30 INFO - PROCESS | 1947 | __end_tp_report 11:04:30 INFO - PROCESS | 1947 | __start_cc_report 11:04:30 INFO - PROCESS | 1947 | _x_x_mozilla_cycle_collect,1217 11:04:30 INFO - PROCESS | 1947 | __end_cc_report 11:04:30 INFO - PROCESS | 1947 | __startTimestamp1463162670566__endTimestamp 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | ------- Summary: start ------- 11:04:30 INFO - PROCESS | 1947 | Number of tests: 14 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:3.90 (3.5%) stddev-sans-first:4.14 11:04:30 INFO - PROCESS | 1947 | Values: 110.0 107.0 112.0 104.0 110.0 111.0 119.0 111.0 108.0 109.0 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:150.00 stddev:19.80 (13.2%) stddev-sans-first:20.95 11:04:30 INFO - PROCESS | 1947 | Values: 149.0 120.0 153.0 151.0 119.0 160.0 143.0 184.0 146.0 126.0 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:1.42 (0.8%) stddev-sans-first:1.42 11:04:30 INFO - PROCESS | 1947 | Values: 183.0 185.0 185.0 185.0 184.0 183.0 185.0 184.0 187.0 182.0 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | [#3] audio-fft Cycles:10 Average:74.40 Median:58.00 stddev:24.58 (42.4%) stddev-sans-first:26.03 11:04:30 INFO - PROCESS | 1947 | Values: 78.0 72.0 72.0 119.0 55.0 58.0 58.0 58.0 118.0 56.0 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:80.00 stddev:19.04 (23.8%) stddev-sans-first:20.14 11:04:30 INFO - PROCESS | 1947 | Values: 90.0 92.0 128.0 81.0 77.0 82.0 117.0 77.0 79.0 115.0 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.50 stddev:2.07 (2.4%) stddev-sans-first:2.13 11:04:30 INFO - PROCESS | 1947 | Values: 87.0 84.0 88.0 84.0 86.0 83.0 89.0 84.0 87.0 84.0 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | [#6] imaging-darkroom Cycles:10 Average:104.10 Median:92.50 stddev:21.16 (22.9%) stddev-sans-first:21.98 11:04:30 INFO - PROCESS | 1947 | Values: 92.0 92.0 93.0 93.0 116.0 87.0 131.0 150.0 94.0 93.0 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:85.00 stddev:22.28 (26.2%) stddev-sans-first:23.14 11:04:30 INFO - PROCESS | 1947 | Values: 84.0 87.0 84.0 84.0 86.0 84.0 96.0 142.0 135.0 87.0 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:57.00 stddev:2.37 (4.2%) stddev-sans-first:2.32 11:04:30 INFO - PROCESS | 1947 | Values: 53.0 58.0 57.0 56.0 57.0 57.0 57.0 57.0 53.0 51.0 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:68.00 stddev:2.95 (4.3%) stddev-sans-first:2.86 11:04:30 INFO - PROCESS | 1947 | Values: 64.0 62.0 70.0 71.0 71.0 69.0 66.0 67.0 67.0 67.0 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:79.00 stddev:14.05 (17.8%) stddev-sans-first:14.59 11:04:30 INFO - PROCESS | 1947 | Values: 80.0 69.0 78.0 93.0 107.0 105.0 108.0 79.0 79.0 84.0 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:119.50 stddev:11.61 (9.7%) stddev-sans-first:12.19 11:04:30 INFO - PROCESS | 1947 | Values: 118.0 128.0 118.0 117.0 118.0 121.0 115.0 107.0 138.0 146.0 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.60 Median:140.00 stddev:16.95 (12.1%) stddev-sans-first:17.53 11:04:30 INFO - PROCESS | 1947 | Values: 132.0 122.0 146.0 133.0 161.0 163.0 172.0 130.0 133.0 134.0 11:04:30 INFO - PROCESS | 1947 | 11:04:30 INFO - PROCESS | 1947 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 11:04:30 INFO - PROCESS | 1947 | Values: 66.0 66.0 64.0 65.0 65.0 66.0 67.0 65.0 66.0 64.0 11:04:30 INFO - PROCESS | 1947 | -------- Summary: end -------- 11:04:30 INFO - PROCESS | 1947 | 11:04:31 INFO - TEST-INFO | 1947: exit 0 11:04:31 INFO - TEST-OK | kraken | took 56291ms 11:04:31 INFO - SUITE-END | took 1168s 11:04:31 INFO - Completed test suite (00:19:28) 11:04:31 INFO - javascript benchmark 11:04:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3084.6915308469142, 3306.504024396341, 3632.037510059833, 3653.7259705522083, 3663.303972245275, 5848.064309710437, 5866.501347385472, 5893.086571581401, 5917.9408205917925, 5921.703914804259, 5881.088431293157, 5889.882202355961, 5918.230630018103, 5923.0, 5952.672603006833, 5246.68519888806, 5278.340207474056, 5309.65487243328, 5315.255864179018, 5369.838904832842, 5405.135178371462, 5415.350157981048, 5420.295361602986, 5425.077736784756, 5427.0, 5335.706536140511, 5383.650062745909, 5388.515033646971, 5401.621886467949, 5406.972675191721, 5399.001184780808, 5410.323709536308, 5423.755930983076, 5433.4566543345945, 5475.589330800206, 5060.569851562622, 5345.0, 5358.4641535846495, 5367.302250707422, 5372.0330340538685, 5696.0, 5750.884982300372, 5758.0, 5781.335146458169, 5799.101139323411, 6276.686165691697, 6314.210723659543, 6314.400131987454, 6323.715432805535, 6323.715432805535, 5268.841934741964, 6241.563090583661, 6300.338464461257, 6304.401081897213, 6348.143000694893, 6035.486983606399, 6072.908906366408, 6074.240719910012, 6076.96961515194, 6086.056661217518, 5378.515933565998, 6238.937610623836, 6338.207724034496, 6407.711652975628, 6427.839304017343, 6212.502999760009, 6238.500919926395, 6250.124982502453, 6278.46633036197, 6355.078513615592, 5519.668819870821, 6164.845878853064, 6314.431701146918, 6343.936560634427, 6350.0792385103905, 6266.216722909637, 6277.591956522902, 6303.6532990685955, 6317.557770956081, 6327.367263273636, 5027.271045698353, 5776.104703770922, 6246.063090536456, 6272.560920735505, 6299.5275354348605, 4940.777665005084, 4946.554810067039, 4947.65366424354, 4958.454569997298, 4979.775910084055, 4471.128130014616, 4509.594136527729, 4527.932081018787, 4553.612942899825, 4587.61005314552, 5992.0712289595185, 6034.668093254913, 6064.120702498113, 6070.3019152797115, 6076.726547305382, 6223.315435302113, 6238.344973777688, 6319.58922670025, 6337.524685648595, 6353.7140828661895, 6071.635701857903, 6076.0278355462915, 6077.118817771398, 6094.0, 6123.938760612336, 5520.365158006881, 5533.446655334435, 5536.833894983157, 5546.473085056913, 5549.889002219933, 5506.201600767947, 6305.054241863757, 6428.100065990671, 6480.513961452815, 6491.285958544557, 6292.2134733158355, 6325.367463253822, 6337.524685648503, 6343.651099189589, 6349.746010159542, 6531.020346947996, 6539.411452969255, 6540.37866402691, 6541.280459149394, 6573.605583664996, 5412.431694672003, 6128.417800308964, 6213.099100630293, 6288.654124023223, 6311.0, 6295.96852015737, 6302.180716506825, 6306.180196574416, 6321.778737744157, 6323.114763932961, 6099.634021958696, 6324.747010119728, 6325.8734825304155, 6338.841528961812, 6348.5238607105575, 6114.60152118864, 6217.875642487215, 6270.686465676789, 6277.466415354564, 6332.176817013758, 6116.816495505142, 6148.754049837957, 6155.47678447337, 6160.199174107337, 6161.229846269216, 6109.890546867989, 6311.463525600376, 6324.2410910691015, 6336.176297081534, 6345.333739957238, 6059.787907423219, 6084.513238940963, 6112.520519325332, 6137.346341658241, 6202.875942481215], "unit": "score", "name": "dojo.html", "value": 5814.215266743677}, {"lowerIsBetter": false, "replicates": [495.9782847334489, 594.6640148316201, 606.1150719948874, 661.8940969444886, 662.8574856405874, 31852.84073579632, 32279.838600806994, 32326.030219093464, 32409.51385729213, 32480.675193248062, 34464.31071378571, 42951.14097718044, 43475.0, 43484.6954591362, 43524.0, 9712.85430718538, 9899.50502474877, 9910.067536830285, 9912.405255684645, 9930.751731206705, 9808.803823923517, 9960.20318374532, 9966.252531060163, 9968.152707019875, 9976.551055202533, 9903.059209375098, 9988.600455981752, 9993.150582200486, 9996.450195239258, 10008.99910008997, 9904.801903961916, 10092.293539452277, 10095.697129086066, 10100.0, 10136.341137826092, 9762.951185244028, 9879.506024698736, 9891.505424728806, 9897.901020989842, 9901.405915645013, 44101.0, 44448.77775611101, 44455.55544444547, 44508.0, 44700.55299446997, 3293.5883014623173, 3490.040238934288, 3689.6494832991093, 3735.252949410102, 3994.021464741157, 29855.785510826114, 30842.69157308443, 31042.379152417052, 31364.529532057037, 31387.058388248162, 2830.844303563303, 2835.53213719736, 2856.685764565896, 2883.7692984561186, 2938.030449951511, 471253.0, 472465.0, 472567.0, 472730.0, 474054.0, 72694.63652681703, 73262.26737732554, 73440.63279683568, 73533.0, 73569.6321518389, 81612.0, 82804.58597707094, 82948.17051829526, 83065.75401368985, 83227.0, 18969.62060758777, 19013.239470421027, 19184.944828034313, 19234.422967311002, 19285.42143735662, 14536.854631453762, 14596.0, 14599.92700036493, 14606.63483412902, 14612.196329201783, 23662.29013129609, 23961.400964976016, 23976.760232397453, 24132.63801042986, 24148.758512415003, 8949.552522373855, 9123.635054597742, 9132.634694612274, 9134.132257435533, 9136.71582104474, 937.7843096087802, 1016.9186465082776, 1033.3438266700548, 1049.9790004199874, 1129.1192869561755, 27852.30369240785, 30973.225669357995, 31153.688463115534, 31207.043397310037, 31574.29347799091, 1001.4341896828269, 1110.5280255891214, 1132.4620805117504, 1232.3222227774688, 1240.8770063092916, 13389.799153012713, 15746.76379854303, 15990.120543370227, 16035.679286414206, 16282.75575866363, 542131.0, 546105.0, 546669.0, 547257.0, 547689.0, 65331.0, 65595.67202164054, 65720.0, 65977.0, 66013.6797264052, 1421.6303761022002, 1530.900491468051, 1540.353051718281, 1564.5619226616566, 1567.7099736548776, 26350.868245659414, 30011.99052649298, 31598.0, 31866.7253309865, 31974.68025319717, 53700.73149634383, 53979.190312144565, 54243.72878135584, 54293.0, 54421.45578544322, 369352.0, 374680.0, 376429.0, 376842.0, 377707.2229277782, 30850.845745771127, 36424.45363319499, 36869.0, 48784.75607621939, 49563.25655115104, 49161.508384915694, 49713.0, 50736.74631626818, 51110.74444627753, 52658.0, 40141.1971760569, 41368.1726365477, 41371.379429307985, 41601.0, 42897.35653965131, 35872.10319741923, 36768.44847327239, 40546.59453405428, 40552.59447405488, 41622.0, 40950.38574421446, 41223.96940076522, 41809.372859406525, 42165.367519486615, 42727.14545709006, 34118.14704632404, 34671.0, 36168.09579760527, 36349.0, 36611.450828237066, 26718.732812671624, 26872.731272687022, 26935.73064269332, 26956.86521567458, 27526.724732752416], "unit": "score", "name": "ext.html", "value": 21132.22204704509}, {"lowerIsBetter": false, "replicates": [372.69066674660024, 377.0441929708192, 378.08880597759395, 384.2161989541336, 384.87491565241305, 20758.792412075876, 21285.680714789272, 21906.0, 22190.334289971288, 22233.888830555843, 12265.693357666063, 12901.22592644442, 12910.870891291084, 12921.483140674385, 12938.870611293883, 6435.131257280254, 6802.557833740816, 6803.421709154728, 6811.761588344409, 6815.591064536144, 4425.911481770363, 4936.35827342445, 5688.687122208277, 6829.0, 7499.437542184358, 7608.771736847876, 7686.53880767153, 7701.576413297266, 7731.45879788415, 7731.806704832368, 7435.479516433852, 7638.54168749874, 7684.654190561439, 7722.806929826771, 7730.7680769577, 3859.4403811447464, 6994.33553812387, 7278.672459739271, 7284.635768211621, 7294.416446684252, 28823.0, 29431.11706648804, 29813.10560683183, 29982.85008574965, 31235.687643123507, 2458.950820983588, 2487.216526794054, 2505.3987043109705, 2567.7817385522253, 2626.1071235779737, 11767.117466189984, 15340.309686064042, 15961.92019039909, 16914.577135571588, 17264.48206553793, 1919.9616007679767, 1957.4323446200585, 1988.6221617892554, 2030.9845077461268, 2070.6023434182016, 115710.0, 124097.0, 125330.3733481336, 126326.0, 127762.3611881944, 19912.203511859363, 19975.800241997393, 20545.383638490868, 20624.48438789042, 20626.58746825085, 31117.599708013193, 31247.843760781052, 31354.52968205479, 31776.523352149736, 31865.362692746014, 11461.255018423775, 11804.232724872856, 11827.822582661267, 11829.52681892732, 11938.76122477563, 8086.474379165335, 10011.948745381776, 10055.195584353234, 10085.899141008496, 10168.898311016943, 7358.632068396559, 8556.828863422821, 8917.152870477294, 8966.0, 9025.32310076747, 2923.348308205857, 3394.9490757638655, 3493.7205023598053, 3532.322146980164, 3654.8903532893523, 879.846026945282, 912.762681702762, 977.9315447918719, 996.7408473796866, 1023.6110278094277, 20468.79531204669, 21264.78735212659, 21273.893630531747, 21345.46636334073, 21986.560268794536, 1014.7361685961703, 1026.5688410867454, 1057.9047885690325, 1078.5362294213407, 1092.1917780842277, 11308.982191602796, 11763.176577639482, 11783.52865885355, 11808.0, 11961.282323060645, 664321.0, 666831.0, 669583.0, 696178.0, 697250.0, 121782.391088044, 124327.0, 125424.0, 126684.36657816652, 130420.0, 1031.8142734307746, 1039.0856046678873, 1044.796264728386, 1054.2116102907767, 1064.9041586257274, 18768.62462750765, 18890.43328700141, 19315.51711207231, 19716.802831971498, 19731.309404170785, 53369.733151333996, 53855.73072134614, 55447.722761385936, 56171.71914140403, 57086.429135709775, 71904.0, 75502.0, 81341.0, 81784.77322840043, 86363.36491758889, 8188.385871059813, 8516.063233044237, 8564.443311184754, 8601.0, 8867.201951824367, 12185.207961482476, 12870.485180592672, 13257.66855828612, 13800.792988104986, 14130.858691412954, 11622.82565761531, 11740.236884602473, 11902.523899043941, 11991.0, 11993.520259189883, 11336.0, 11345.37600431951, 11496.137789665641, 11665.24175928562, 11727.061835053346, 11943.701407464883, 12013.519459221883, 12136.332501712137, 12201.938990304992, 12307.87692123103, 8415.200555947175, 8419.452735572413, 8522.446041007315, 8581.8712719308, 8741.169588889044, 11207.551697931991, 11840.585579504675, 12004.39978001114, 12119.212251203997, 12119.454624542093], "unit": "score", "name": "jquery.html", "value": 11042.222509085026}, {"lowerIsBetter": false, "replicates": [1506.224294488338, 1635.3785561486636, 1667.9332826686932, 1965.6461836869366, 2039.7756246812858, 8390.496570205793, 9085.636574537019, 9301.395409298408, 9307.115823996717, 9321.300902432311, 8962.327825413087, 9012.279017678586, 9113.726588202348, 9122.361434699573, 9137.22333601643, 2588.7670109690075, 2610.973890261092, 2612.4905643399543, 2614.398688301692, 2616.4636249568794, 2549.7067837198683, 2619.109502769058, 2620.0, 2621.3577673470027, 2637.1297471834346, 2602.882870270833, 2612.8171028028046, 2615.986920065397, 2617.8429294242405, 2627.8029147813895, 2577.7293384194672, 2583.677040369954, 2629.368951451657, 2632.0787724296533, 2636.1037247336, 2580.8580528070947, 2598.986395305832, 2611.2949503634104, 2631.2369412870244, 2634.894604215829, 9215.0, 9282.164605185499, 9287.931887832918, 9289.53552322388, 9297.163255307054, 5405.5135037846385, 5575.219469274305, 5596.4403559644115, 5599.944000559983, 5607.186957891083, 3651.6165802590613, 3722.8883133506038, 3793.165503589206, 3808.447775072627, 3816.084139806454, 1078.1267173589417, 1087.3638921231088, 1089.1667874076338, 1109.8557187565564, 1130.4347826086957, 11992.280463172237, 12005.459754311078, 12016.158868879182, 12039.09706771987, 12057.397130143458, 4941.530554597308, 4955.380577427822, 4991.001799640087, 5040.31955685985, 5074.061298659686, 8622.267107295826, 10233.0, 10238.846417303746, 10245.48772561369, 10259.640912568024, 5646.604737668324, 5671.234383358276, 5675.091985282335, 5681.4034526374135, 5686.3744988051285, 3795.3358162321483, 4761.809527618856, 4996.800127994912, 5191.273221748958, 5258.710770907637, 4085.565996663867, 4123.340265557496, 4148.43996060534, 4182.811773470201, 4188.8324467020975, 1320.650027742649, 1349.379285528648, 1351.6080336702246, 1358.802973568827, 1363.7340718559785, 1415.6531649745878, 1418.1349376880096, 1442.451868290043, 1450.4415799917108, 1458.2417143085536, 8584.05575386707, 8593.65625374978, 8630.136986301446, 8636.654533818577, 8652.307815374756, 537.2076187623303, 544.6895269696236, 548.832606055149, 552.3316786688152, 552.6076485695121, 6392.296847346788, 6413.518986076063, 6425.421712045845, 6457.0, 6464.903026454607, 10919.290246133976, 11464.31214127155, 11470.942645286721, 11480.368579728196, 11493.425328733698, 10554.630587929385, 11071.114310855111, 11150.163737719704, 11282.435878206057, 11317.717057073474, 8697.95651021741, 8798.340124490689, 8820.470771753715, 8861.955690221508, 8871.822563548692, 8471.788205294917, 8480.236778689701, 8526.48841069513, 8624.0, 8640.56797160152, 9945.850812237966, 9973.055254225357, 10015.098641122335, 10129.0, 10277.177825773771, 10153.64462243818, 10530.894691052992, 10740.731481712706, 10776.461176941279, 10990.340579565252, 7145.285471452813, 7333.596652183967, 7335.963320183365, 7744.651490683045, 8005.879911801211, 8077.87883181741, 8149.470284431493, 8448.028476725009, 8691.0, 8691.435056721293, 7503.5497870127965, 7591.506552074097, 7655.655495502604, 7673.462857599914, 7704.075510938723, 7443.665035073326, 7501.9744668940175, 7514.62426878643, 7600.50596711212, 7637.274458926393, 7989.800254993672, 8027.919720802717, 8050.154733752872, 8055.436119471581, 8097.676092956216, 7334.853302933805, 7362.300581444754, 7404.851902962018, 7413.369863561657, 7451.813704657427, 7488.026556547614, 7492.100947886289, 7543.283388078124, 7546.66040028189, 7551.018367612175], "unit": "score", "name": "mootools.html", "value": 5073.454189773239}, {"lowerIsBetter": false, "replicates": [316.49361022364207, 333.11723931581304, 335.43646673588364, 343.30309471772296, 343.6408952644486, 5218.373795144578, 6535.215774107108, 6538.0, 6586.077949087132, 6592.901106483395, 6479.222493300798, 6486.513511486645, 6514.446272066868, 6519.576227545218, 6529.608223506593, 4685.672002959795, 4797.0, 4811.398575178103, 4896.0, 4951.356323677916, 4887.535684110004, 4896.338994235786, 4915.943072239468, 4943.678660887049, 4948.15881300178, 4881.902361952759, 4889.584385327234, 4889.706617602955, 4901.901961960759, 4905.460399356068, 3762.473253744478, 4742.099001189763, 4883.755812209375, 4886.584640305578, 4892.290617860391, 4188.643965262956, 4199.118185181115, 4206.41110244566, 4212.7682977436225, 4218.987443013685, 6288.213973253343, 6303.936960630381, 6314.273858506284, 6324.525660575475, 6327.4938004959495, 4664.55686709762, 5756.712164391805, 5756.942430575683, 5760.0, 5766.192733017381, 5578.693171875545, 6964.408025317804, 6966.268541803089, 6966.686499107502, 6972.860542789116, 3882.3011857865854, 4596.701214421086, 4781.258904869751, 4782.832600858988, 4787.353707249512, 7140.678669459887, 7301.269873012656, 7301.926980730178, 7311.268873112699, 7311.670974806147, 4849.321095046696, 4857.368542089576, 4883.902321953612, 4890.046440943982, 4892.657513974059, 4943.307936888838, 4954.1825598775795, 4956.182229932021, 4956.900861982812, 4966.279889416014, 5783.537317014629, 5792.189093526909, 5795.362510123883, 5805.867855768169, 5806.506446951972, 5618.943810561842, 6727.428168605626, 6967.756128535579, 6985.720571177096, 6997.230304666483, 1688.5187721499315, 1703.582622257555, 1713.4345665930214, 1716.7339062445342, 1721.5437908954136, 1043.1289872956168, 1052.8262836632023, 1103.426218366445, 1108.9112870970303, 1141.3779490177874, 5358.30342055538, 5823.184754134425, 6675.7997260082275, 6710.060591517192, 6713.160854893138, 7228.927710722931, 7254.165770936304, 7258.383037441877, 7277.745278915212, 7280.580286844014, 5497.642653227527, 6648.301928297556, 6686.398224159849, 6687.565308254948, 6812.386885180357, 3799.1831756172555, 3838.808059597009, 3843.5964223756664, 3843.5964223756664, 3849.4610754494392, 7395.963020184865, 7643.617819109022, 7646.9617651912495, 7651.885221721679, 7665.578393188428, 7473.252674732592, 7495.8500829983095, 7502.324790768748, 7506.24937506245, 7514.0607424071995, 7579.810504737426, 7591.734289299848, 7607.315341619281, 7619.771406857803, 7626.733064342721, 5894.70526473666, 6982.476314276348, 7261.4190864729635, 7269.0, 7278.96360518194, 5982.252218472691, 6960.338767817049, 7122.145342558926, 7138.535995160298, 7150.606716630636, 6111.663858487826, 7606.04924384452, 7608.934749135236, 7626.351760100453, 7629.580373079534, 4616.607588354893, 4663.626909847272, 4671.719696818202, 4677.555632214934, 4682.531746825291, 7009.1589009319205, 7237.986681864438, 7261.128664560287, 7263.16473605521, 7277.854442911218, 6928.584284942919, 7007.544509606859, 7033.683484243119, 7042.753503627348, 7057.082579264663, 6353.555251132377, 6379.106925030406, 6948.687309071003, 7002.124734408199, 7008.5094043416475, 6822.181338239443, 6828.146481689789, 6833.521653484408, 6836.623985680835, 6838.076859623887, 6753.729850806109, 7016.964915175391, 7019.578825270296, 7026.437884969292, 7033.331833475811, 6644.169478815148, 6799.6600169990315, 6819.113515242987, 6875.0, 6876.312368763083], "unit": "score", "name": "prototype.html", "value": 5130.418052014691}, {"lowerIsBetter": false, "replicates": [644.6100109433793, 725.6190499987506, 756.3306473770715, 756.965936532856, 786.1313248860008, 15387.461438849628, 15576.68846623067, 15611.92194039031, 15613.375464981402, 15643.530694079182, 14315.713685726305, 14355.92822035891, 14377.0, 14382.208978506178, 14414.49549265776, 790.1703211627782, 809.7854068671777, 961.3414810854553, 986.4032260482412, 994.4282037828242, 962.5283611030579, 971.0241207586366, 974.2985050763474, 974.7465658928694, 975.9902400976006, 1052.8736551613817, 1055.3456856748787, 1057.1701214546583, 1058.6083149234794, 1059.2532264753331, 845.2899564365931, 1024.9948750256237, 1048.192891473565, 1049.3651340938775, 1050.5902697947806, 787.2049230277404, 787.6180052674448, 788.1448628238368, 788.3141666749907, 791.6477167660394, 15176.241187940559, 15215.239238038053, 15246.695066098728, 15280.847191528164, 15283.847161528354, 12865.163764355288, 13255.60233192996, 13370.866291337157, 13430.798538021938, 13504.189748615114, 10239.080848187918, 10291.588336466531, 10452.686419407353, 10606.204534659853, 11009.61466348674, 3538.274653695986, 3543.1496440854266, 3628.219932714479, 3672.265546890633, 3677.8161091945294, 79514.60242698807, 80795.0, 81168.59415702942, 81176.18823811745, 81439.778403324, 9593.472359020181, 9784.902150978542, 9822.901770982198, 10121.1903047756, 10140.645077422403, 21946.45133871666, 21970.780292197192, 21982.780172198072, 22020.33938981833, 22087.779122208573, 6723.327667233335, 7516.0, 7682.692692292246, 7721.420893432903, 7793.7272195474025, 4139.875803725893, 4225.3239481683395, 4287.6998610097, 4304.74171549708, 4421.668374871898, 3680.8895733128047, 3741.382671859167, 3754.887353379403, 3757.4739536464917, 3760.623937606272, 556.4546744190716, 580.8818025301279, 648.7664440801308, 653.1737352249409, 671.8320419895026, 398.8105649816372, 429.83552615326875, 474.10157751062235, 486.75175660412737, 496.81866118866355, 7888.684452621946, 7992.800179995546, 8018.599070046591, 8028.799280017929, 8263.173682631688, 512.4619149892673, 515.5128403658507, 548.6488647265753, 566.1846940405802, 574.3452464190826, 3617.8371973261264, 3762.8682996095004, 3792.7724336539345, 3877.127646279621, 3935.980320098381, 95117.0, 97896.0, 98868.51697224547, 99146.0, 99594.0, 81244.59377703074, 81588.77616835752, 81673.0, 81805.0, 82244.58877705692, 71104.64447677729, 73468.0, 74828.62585687036, 75296.4940701183, 75863.62068189624, 7609.505382150142, 7652.923470765221, 7809.062912450542, 7922.0, 8124.55314957683, 51226.206725400174, 52699.209511856585, 53344.0, 53914.73042634762, 54464.18303725368, 67048.6647566759, 68580.6570967162, 73402.26597734168, 73452.26547734668, 73655.52688946298, 9915.504224788587, 9916.256280779115, 9930.354526955725, 10017.0, 10058.8491172631, 10286.485675716334, 10674.0, 10689.89310106889, 10850.29473084247, 10941.781164376827, 9811.0, 10128.34165779222, 10347.379157250589, 10392.42841643717, 10785.137189025016, 11402.372869492257, 11480.712982175512, 11571.479283432434, 11675.649730508097, 11815.881841181477, 11091.778164436828, 11229.71925701864, 11268.742618809261, 11427.828582571101, 11758.235714678518, 9712.368696034735, 9760.85358719634, 9841.507924603598, 9887.505624718879, 10241.0, 9551.331406801457, 9703.6118555257, 9709.0, 9756.951215243878, 9926.15627671656], "unit": "score", "name": "yui.html", "value": 6971.190604066663}], "name": "dromaeo_css", "value": 7916.7883176633295}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 107.0, 112.0, 104.0, 110.0, 111.0, 119.0, 111.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [149.0, 120.0, 153.0, 151.0, 119.0, 160.0, 143.0, 184.0, 146.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.1}, {"lowerIsBetter": true, "replicates": [183.0, 185.0, 185.0, 185.0, 184.0, 183.0, 185.0, 184.0, 187.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [78.0, 72.0, 72.0, 119.0, 55.0, 58.0, 58.0, 58.0, 118.0, 56.0], "unit": "score", "name": "audio-fft", "value": 74.4}, {"lowerIsBetter": true, "replicates": [90.0, 92.0, 128.0, 81.0, 77.0, 82.0, 117.0, 77.0, 79.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 93.8}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 88.0, 84.0, 86.0, 83.0, 89.0, 84.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.6}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 93.0, 93.0, 116.0, 87.0, 131.0, 150.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 104.1}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 84.0, 84.0, 86.0, 84.0, 96.0, 142.0, 135.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [53.0, 58.0, 57.0, 56.0, 57.0, 57.0, 57.0, 57.0, 53.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 70.0, 71.0, 71.0, 69.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [80.0, 69.0, 78.0, 93.0, 107.0, 105.0, 108.0, 79.0, 79.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.2}, {"lowerIsBetter": true, "replicates": [118.0, 128.0, 118.0, 117.0, 118.0, 121.0, 115.0, 107.0, 138.0, 146.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [132.0, 122.0, 146.0, 133.0, 161.0, 163.0, 172.0, 130.0, 133.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.6}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 64.0, 65.0, 65.0, 66.0, 67.0, 65.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.4}], "name": "kraken", "value": 1436.1}]} 11:04:31 INFO - Return code: 0 11:04:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:04:31 INFO - # TBPL SUCCESS # 11:04:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:04:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:04:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:04:31 INFO - 2016-05-13 11:04:31.862 screenresolution[1951:12640] starting screenresolution argv=screenresolution get 11:04:31 INFO - 2016-05-13 11:04:31.865 screenresolution[1951:12640] Display 0: 1600x1200x32@60 11:04:31 INFO - 2016-05-13 11:04:31.871 screenresolution[1952:12643] starting screenresolution argv=screenresolution list 11:04:31 INFO - Available Modes on Display 0 11:04:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:04:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:04:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:04:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:04:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:04:32 INFO - Intel Iris: 11:04:32 INFO - Chipset Model: Intel Iris 11:04:32 INFO - Type: GPU 11:04:32 INFO - Bus: Built-In 11:04:32 INFO - VRAM (Dynamic, Max): 1536 MB 11:04:32 INFO - Vendor: Intel (0x8086) 11:04:32 INFO - Device ID: 0x0a2e 11:04:32 INFO - Revision ID: 0x0009 11:04:32 INFO - Displays: 11:04:32 INFO - Display: 11:04:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:04:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:04:32 INFO - Display Serial Number: 1600x1200 60 11:04:32 INFO - Main Display: Yes 11:04:32 INFO - Mirror: Off 11:04:32 INFO - Online: Yes 11:04:32 INFO - Rotation: Supported 11:04:32 INFO - Return code: 0 11:04:32 INFO - Running post-action listener: _resource_record_post_action 11:04:32 INFO - Running post-run listener: _resource_record_post_run 11:04:33 INFO - Total resource usage - Wall time: 1193s; CPU: 52.0%; Read bytes: 1355776; Write bytes: 509094400; Read time: 19; Write time: 1558 11:04:33 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 196332032; Write bytes: 196210688; Read time: 18000; Write time: 398 11:04:33 INFO - run-tests - Wall time: 1171s; CPU: 52.0%; Read bytes: 1355776; Write bytes: 302877184; Read time: 19; Write time: 1128 11:04:33 INFO - Running post-run listener: _upload_blobber_files 11:04:33 INFO - Blob upload gear active. 11:04:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:04:33 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 11:04:33 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'] 11:04:33 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 11:04:33 INFO - (blobuploader) - INFO - Open directory for files ... 11:04:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:04:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:04:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:04:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:04:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:04:34 INFO - (blobuploader) - INFO - Done attempting. 11:04:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:04:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:04:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:04:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:04:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:04:35 INFO - (blobuploader) - INFO - Done attempting. 11:04:35 INFO - (blobuploader) - INFO - Iteration through files over. 11:04:35 INFO - Return code: 0 11:04:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:04:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:04:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8606832033a23b9e3b6fa0c293d10c33a702d9afd49c249ed40444c37ca5ba5844f88de55f693b3a74cba163690e2ee3add19fe78eaecbc9d72e7e4d9a7cabe2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/630d3347f9c496d2e1cc8c89ca12a3258c5403bd53388dc72cf637a2838a6cdee4080cf747639d5ff627d3b3b8ad3e98a4ddab0b2acc11158b64193df3b62e47"} 11:04:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:04:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:04:35 INFO - Contents: 11:04:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8606832033a23b9e3b6fa0c293d10c33a702d9afd49c249ed40444c37ca5ba5844f88de55f693b3a74cba163690e2ee3add19fe78eaecbc9d72e7e4d9a7cabe2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/630d3347f9c496d2e1cc8c89ca12a3258c5403bd53388dc72cf637a2838a6cdee4080cf747639d5ff627d3b3b8ad3e98a4ddab0b2acc11158b64193df3b62e47"} 11:04:35 INFO - Running post-run listener: copy_logs_to_upload_dir 11:04:35 INFO - Copying logs to upload dir... 11:04:35 INFO - mkdir: /builds/slave/test/build/upload/logs 11:04:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.663665 ========= master_lag: 53.98 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2016-05-13 11:05:29.745986) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-05-13 11:05:29.750058) ========= 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.4YakC2GtoC/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.qhMFNckQlX/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8606832033a23b9e3b6fa0c293d10c33a702d9afd49c249ed40444c37ca5ba5844f88de55f693b3a74cba163690e2ee3add19fe78eaecbc9d72e7e4d9a7cabe2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/630d3347f9c496d2e1cc8c89ca12a3258c5403bd53388dc72cf637a2838a6cdee4080cf747639d5ff627d3b3b8ad3e98a4ddab0b2acc11158b64193df3b62e47"} build_url:https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010716 build_url: 'https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8606832033a23b9e3b6fa0c293d10c33a702d9afd49c249ed40444c37ca5ba5844f88de55f693b3a74cba163690e2ee3add19fe78eaecbc9d72e7e4d9a7cabe2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/630d3347f9c496d2e1cc8c89ca12a3258c5403bd53388dc72cf637a2838a6cdee4080cf747639d5ff627d3b3b8ad3e98a4ddab0b2acc11158b64193df3b62e47"}' ========= master_lag: 1.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-05-13 11:05:30.821131) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 11:05:30.821489) ========= 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.4YakC2GtoC/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.qhMFNckQlX/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.005120 ========= master_lag: 1.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 11:05:31.905458) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-05-13 11:05:31.905719) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-05-13 11:05:35.209644) ========= ========= Total master_lag: 56.25 =========