builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0107 starttime: 1468608670.95 results: success (0) buildid: 20160712072157 builduid: 84a70d87410b4a8d8ec167a364733e3c revision: 0f717e101c78709aa6e5b0c29826c856a20d388b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 11:51:10.950900) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 11:51:10.951365) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 11:51:10.951637) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 11:51:10.975596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:51:10.975968) ========= 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.O74jjRcrll/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.DZceUXPfH4/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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-07-15 11:51:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 81.5M=0s 2016-07-15 11:51:11 (81.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137377 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:51:11.138539) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:51:11.138863) ========= 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.O74jjRcrll/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.DZceUXPfH4/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.027384 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:51:11.187211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:51:11.189000) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0f717e101c78709aa6e5b0c29826c856a20d388b --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 0f717e101c78709aa6e5b0c29826c856a20d388b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O74jjRcrll/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.DZceUXPfH4/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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-07-15 11:51:11,263 truncating revision to first 12 chars 2016-07-15 11:51:11,263 Setting DEBUG logging. 2016-07-15 11:51:11,263 attempt 1/10 2016-07-15 11:51:11,263 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0f717e101c78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 11:51:11,927 unpacking tar archive at: mozilla-beta-0f717e101c78/testing/mozharness/ program finished with exit code 0 elapsedTime=0.919865 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:51:12.130172) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 11:51:12.130513) ========= script_repo_revision: 0f717e101c78709aa6e5b0c29826c856a20d388b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 11:51:12.130921) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 11:51:12.131202) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 11:51:12.147436) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-15 11:51:12.147782) ========= /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.O74jjRcrll/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.DZceUXPfH4/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 11:51:12 INFO - MultiFileLogger online at 20160715 11:51:12 in /builds/slave/test 11:51:12 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 11:51:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:51:12 INFO - {'append_to_log': False, 11:51:12 INFO - 'base_work_dir': '/builds/slave/test', 11:51:12 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:51:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:51:12 INFO - 'branch': 'Mozilla-Beta', 11:51:12 INFO - 'buildbot_json_path': 'buildprops.json', 11:51:12 INFO - 'config_files': ('talos/mac_config.py',), 11:51:12 INFO - 'default_actions': ('clobber', 11:51:12 INFO - 'read-buildbot-config', 11:51:12 INFO - 'download-and-extract', 11:51:12 INFO - 'populate-webroot', 11:51:12 INFO - 'create-virtualenv', 11:51:12 INFO - 'install', 11:51:12 INFO - 'run-tests'), 11:51:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:51:12 INFO - 'download_minidump_stackwalk': True, 11:51:12 INFO - 'download_symbols': 'ondemand', 11:51:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:51:12 INFO - 'tooltool.py': '/tools/tooltool.py', 11:51:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:51:12 INFO - '/tools/misc-python/virtualenv.py')}, 11:51:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:51:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:51:12 INFO - 'installer_path': 'installer.exe', 11:51:12 INFO - 'log_level': 'info', 11:51:12 INFO - 'log_name': 'talos', 11:51:12 INFO - 'log_to_console': True, 11:51:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:51:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:51:12 INFO - 'opt_config_files': (), 11:51:12 INFO - 'pip_index': False, 11:51:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:51:12 INFO - 'cmd': ('bash', 11:51:12 INFO - '-c', 11:51:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:51:12 INFO - 'enabled': True, 11:51:12 INFO - 'halt_on_failure': False, 11:51:12 INFO - 'name': 'check_screen_resolution'},), 11:51:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:51:12 INFO - 'cmd': ('bash', 11:51:12 INFO - '-c', 11:51:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:51:12 INFO - 'enabled': True, 11:51:12 INFO - 'halt_on_failure': False, 11:51:12 INFO - 'name': 'check_screen_resolution'},), 11:51:12 INFO - 'run_cmd_checks_enabled': True, 11:51:12 INFO - 'sps_profile': False, 11:51:12 INFO - 'sps_profile_interval': 0, 11:51:12 INFO - 'suite': 'dromaeojs', 11:51:12 INFO - 'system_bits': '32', 11:51:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:51:12 INFO - 'title': 't-yosemite-r7-0107', 11:51:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:51:12 INFO - 'use_talos_json': True, 11:51:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:51:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:51:12 INFO - 'work_dir': 'build'} 11:51:12 INFO - ##### 11:51:12 INFO - ##### Running clobber step. 11:51:12 INFO - ##### 11:51:12 INFO - Running pre-action listener: _resource_record_pre_action 11:51:12 INFO - Running main action method: clobber 11:51:12 INFO - rmtree: /builds/slave/test/build 11:51:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:51:14 INFO - Running post-action listener: _resource_record_post_action 11:51:14 INFO - ##### 11:51:14 INFO - ##### Running read-buildbot-config step. 11:51:14 INFO - ##### 11:51:14 INFO - Running pre-action listener: _resource_record_pre_action 11:51:14 INFO - Running main action method: read_buildbot_config 11:51:14 INFO - Using buildbot properties: 11:51:14 INFO - { 11:51:14 INFO - "project": "", 11:51:14 INFO - "product": "firefox", 11:51:14 INFO - "script_repo_revision": "production", 11:51:14 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:51:14 INFO - "repository": "", 11:51:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:51:14 INFO - "buildid": "20160712072157", 11:51:14 INFO - "pgo_build": "False", 11:51:14 INFO - "basedir": "/builds/slave/test", 11:51:14 INFO - "buildnumber": 41, 11:51:14 INFO - "slavename": "t-yosemite-r7-0107", 11:51:14 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:51:14 INFO - "platform": "yosemite_r7", 11:51:14 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:51:14 INFO - "branch": "mozilla-beta", 11:51:14 INFO - "repo_path": "releases/mozilla-beta", 11:51:14 INFO - "revision": "0f717e101c78709aa6e5b0c29826c856a20d388b", 11:51:14 INFO - "stage_platform": "macosx64", 11:51:14 INFO - "builduid": "84a70d87410b4a8d8ec167a364733e3c", 11:51:14 INFO - "slavebuilddir": "test" 11:51:14 INFO - } 11:51:14 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.dmg. 11:51:14 INFO - Running post-action listener: _resource_record_post_action 11:51:14 INFO - ##### 11:51:14 INFO - ##### Running download-and-extract step. 11:51:14 INFO - ##### 11:51:14 INFO - Running pre-action listener: _resource_record_pre_action 11:51:14 INFO - Running main action method: download_and_extract 11:51:14 INFO - mkdir: /builds/slave/test/build/tests 11:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:14 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.test_packages.json 11:51:14 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 11:51:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 11:51:14 INFO - Downloaded 1165 bytes. 11:51:14 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 11:51:14 INFO - Using the following test package requirements: 11:51:14 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 11:51:14 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:51:14 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 11:51:14 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:51:14 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 11:51:14 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:51:14 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:51:14 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 11:51:14 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 11:51:14 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:51:14 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 11:51:14 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:51:14 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 11:51:14 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:51:14 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 11:51:14 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:51:14 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 11:51:14 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 11:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:14 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.common.tests.zip 11:51:14 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 11:51:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 11:51:14 INFO - Downloaded 18351484 bytes. 11:51:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:51:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:51:18 INFO - Return code: 0 11:51:18 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.common.tests.zip 11:51:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 11:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 11:51:18 INFO - Downloaded 18351484 bytes. 11:51:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:51:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:51:21 INFO - Return code: 0 11:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.talos.tests.zip 11:51:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 11:51:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 11:51:22 INFO - Downloaded 10840145 bytes. 11:51:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:51:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:51:22 INFO - Return code: 0 11:51:22 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')]} 11:51:22 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.dmg 11:51:22 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 11:51:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 11:51:24 INFO - Downloaded 86190143 bytes. 11:51:24 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.dmg 11:51:24 INFO - mkdir: /builds/slave/test/properties 11:51:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:51:24 INFO - Writing to file /builds/slave/test/properties/build_url 11:51:24 INFO - Contents: 11:51:24 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.dmg 11:51:24 INFO - Running post-action listener: _resource_record_post_action 11:51:24 INFO - Running post-action listener: set_extra_try_arguments 11:51:24 INFO - ##### 11:51:24 INFO - ##### Running populate-webroot step. 11:51:24 INFO - ##### 11:51:24 INFO - Running pre-action listener: _resource_record_pre_action 11:51:24 INFO - Running main action method: populate_webroot 11:51:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:51:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:51:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:51:24 INFO - '--tppagecycles', 11:51:24 INFO - '7'], 11:51:24 INFO - 'tests': ['tsvgm']}}, 11:51:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:51:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:51:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:51:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:51:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:51:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:51:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:24 INFO - 'talos_options': ['--disable-e10s'], 11:51:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:24 INFO - 'talos_options': ['--disable-e10s'], 11:51:24 INFO - 'tests': ['damp', 'tps']}, 11:51:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:24 INFO - 'tests': ['damp', 'tps']}, 11:51:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:51:24 INFO - 'tests': ['dromaeo_dom']}, 11:51:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:51:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:51:24 INFO - 'tests': ['a11yr', 11:51:24 INFO - 'ts_paint', 11:51:24 INFO - 'tpaint', 11:51:24 INFO - 'sessionrestore', 11:51:24 INFO - 'sessionrestore_no_auto_restore', 11:51:24 INFO - 'tabpaint']}, 11:51:24 INFO - 'other-e10s': {'tests': ['a11yr', 11:51:24 INFO - 'ts_paint', 11:51:24 INFO - 'tpaint', 11:51:24 INFO - 'sessionrestore', 11:51:24 INFO - 'sessionrestore_no_auto_restore', 11:51:24 INFO - 'tabpaint']}, 11:51:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:51:24 INFO - 'ts_paint', 11:51:24 INFO - 'tpaint', 11:51:24 INFO - 'sessionrestore', 11:51:24 INFO - 'sessionrestore_no_auto_restore', 11:51:24 INFO - 'tabpaint']}, 11:51:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:51:24 INFO - 'ts_paint', 11:51:24 INFO - 'tpaint', 11:51:24 INFO - 'sessionrestore', 11:51:24 INFO - 'sessionrestore_no_auto_restore', 11:51:24 INFO - 'tabpaint']}, 11:51:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:51:24 INFO - 'tests': ['a11yr', 11:51:24 INFO - 'ts_paint', 11:51:24 INFO - 'tpaint', 11:51:24 INFO - 'sessionrestore', 11:51:24 INFO - 'sessionrestore_no_auto_restore', 11:51:24 INFO - 'tabpaint']}, 11:51:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:51:24 INFO - 'tests': ['a11yr', 11:51:24 INFO - 'ts_paint', 11:51:24 INFO - 'tpaint', 11:51:24 INFO - 'sessionrestore', 11:51:24 INFO - 'sessionrestore_no_auto_restore', 11:51:24 INFO - 'tabpaint']}, 11:51:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:51:24 INFO - 'tests': ['tsvgx', 11:51:24 INFO - 'tsvgr_opacity', 11:51:24 INFO - 'tart', 11:51:24 INFO - 'tscrollx', 11:51:24 INFO - 'cart']}, 11:51:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:51:24 INFO - 'tsvgr_opacity', 11:51:24 INFO - 'tart', 11:51:24 INFO - 'tscrollx', 11:51:24 INFO - 'cart']}, 11:51:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:24 INFO - 'talos_options': ['--disable-e10s'], 11:51:24 INFO - 'tests': ['tp5o']}, 11:51:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:24 INFO - 'tests': ['tp5o']}, 11:51:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:24 INFO - 'talos_options': ['--disable-e10s', 11:51:24 INFO - '--xperf_path', 11:51:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:51:24 INFO - 'tests': ['tp5n']}, 11:51:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:24 INFO - 'talos_options': ['--xperf_path', 11:51:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:51:24 INFO - 'tests': ['tp5n']}}, 11:51:24 INFO - 'talos.zip': {'path': '', 11:51:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:51:24 INFO - Running post-action listener: _resource_record_post_action 11:51:24 INFO - ##### 11:51:24 INFO - ##### Running create-virtualenv step. 11:51:24 INFO - ##### 11:51:24 INFO - Running pre-action listener: _resource_record_pre_action 11:51:24 INFO - Running main action method: create_virtualenv 11:51:24 INFO - Creating virtualenv /builds/slave/test/build/venv 11:51:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:51:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:51:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:51:24 INFO - Using real prefix '/tools/python27' 11:51:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:51:25 INFO - Installing distribute.............................................................................................................................................................................................done. 11:51:28 INFO - Installing pip.................done. 11:51:28 INFO - Return code: 0 11:51:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104b9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104baa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6d84dd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a39e00>, '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 0x1048a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a34b20>, '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.O74jjRcrll/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.DZceUXPfH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 11:51:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O74jjRcrll/Render', 11:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:28 INFO - 'HOME': '/Users/cltbld', 11:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:28 INFO - 'LOGNAME': 'cltbld', 11:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:28 INFO - 'MOZ_NO_REMOTE': '1', 11:51:28 INFO - 'NO_EM_RESTART': '1', 11:51:28 INFO - 'PAGER': '/bin/cat', 11:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:28 INFO - 'PWD': '/builds/slave/test', 11:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:28 INFO - 'SHELL': '/bin/bash', 11:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DZceUXPfH4/Listeners', 11:51:28 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 11:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:28 INFO - 'USER': 'cltbld', 11:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:28 INFO - 'XPC_FLAGS': '0x0', 11:51:28 INFO - 'XPC_SERVICE_NAME': '0', 11:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:51:28 INFO - Cleaning up... 11:51:28 INFO - Return code: 0 11:51:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104b9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104baa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6d84dd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a39e00>, '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 0x1048a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a34b20>, '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.O74jjRcrll/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.DZceUXPfH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 11:51:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O74jjRcrll/Render', 11:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:28 INFO - 'HOME': '/Users/cltbld', 11:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:28 INFO - 'LOGNAME': 'cltbld', 11:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:28 INFO - 'MOZ_NO_REMOTE': '1', 11:51:28 INFO - 'NO_EM_RESTART': '1', 11:51:28 INFO - 'PAGER': '/bin/cat', 11:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:28 INFO - 'PWD': '/builds/slave/test', 11:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:28 INFO - 'SHELL': '/bin/bash', 11:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DZceUXPfH4/Listeners', 11:51:28 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 11:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:28 INFO - 'USER': 'cltbld', 11:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:28 INFO - 'XPC_FLAGS': '0x0', 11:51:28 INFO - 'XPC_SERVICE_NAME': '0', 11:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:28 INFO - Downloading/unpacking psutil>=0.7.1 11:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:51:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:51:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:51:32 INFO - Installing collected packages: psutil 11:51:32 INFO - Running setup.py install for psutil 11:51:32 INFO - building 'psutil._psutil_osx' extension 11:51:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:51:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:51:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:51:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:51:32 INFO - building 'psutil._psutil_posix' extension 11:51:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:51:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:51:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:51:33 INFO - ^ 11:51:33 INFO - 1 warning generated. 11:51:33 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 11:51:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:51:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:51:33 INFO - Successfully installed psutil 11:51:33 INFO - Cleaning up... 11:51:33 INFO - Return code: 0 11:51:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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', '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 0x104b9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104baa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6d84dd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a39e00>, '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 0x1048a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a34b20>, '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.O74jjRcrll/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.DZceUXPfH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 11:51: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:51: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 mozsystemmonitor==0.0.0 11:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O74jjRcrll/Render', 11:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:33 INFO - 'HOME': '/Users/cltbld', 11:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:33 INFO - 'LOGNAME': 'cltbld', 11:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:33 INFO - 'MOZ_NO_REMOTE': '1', 11:51:33 INFO - 'NO_EM_RESTART': '1', 11:51:33 INFO - 'PAGER': '/bin/cat', 11:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:33 INFO - 'PWD': '/builds/slave/test', 11:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:33 INFO - 'SHELL': '/bin/bash', 11:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DZceUXPfH4/Listeners', 11:51:33 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 11:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:33 INFO - 'USER': 'cltbld', 11:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:33 INFO - 'XPC_FLAGS': '0x0', 11:51:33 INFO - 'XPC_SERVICE_NAME': '0', 11:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:51:36 INFO - Installing collected packages: mozsystemmonitor 11:51:36 INFO - Running setup.py install for mozsystemmonitor 11:51:36 INFO - Successfully installed mozsystemmonitor 11:51:36 INFO - Cleaning up... 11:51:36 INFO - Return code: 0 11:51:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104b9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104baa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6d84dd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a39e00>, '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 0x1048a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a34b20>, '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.O74jjRcrll/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.DZceUXPfH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 11:51:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:51:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:51:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O74jjRcrll/Render', 11:51:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:36 INFO - 'HOME': '/Users/cltbld', 11:51:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:36 INFO - 'LOGNAME': 'cltbld', 11:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:36 INFO - 'MOZ_NO_REMOTE': '1', 11:51:36 INFO - 'NO_EM_RESTART': '1', 11:51:36 INFO - 'PAGER': '/bin/cat', 11:51:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:36 INFO - 'PWD': '/builds/slave/test', 11:51:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:36 INFO - 'SHELL': '/bin/bash', 11:51:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DZceUXPfH4/Listeners', 11:51:36 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 11:51:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:36 INFO - 'USER': 'cltbld', 11:51:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:36 INFO - 'XPC_FLAGS': '0x0', 11:51:36 INFO - 'XPC_SERVICE_NAME': '0', 11:51:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:36 INFO - Downloading/unpacking blobuploader==1.2.4 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:39 INFO - Downloading blobuploader-1.2.4.tar.gz 11:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:51:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:51:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:40 INFO - Downloading docopt-0.6.1.tar.gz 11:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:51:40 INFO - Installing collected packages: blobuploader, requests, docopt 11:51:40 INFO - Running setup.py install for blobuploader 11:51:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:51:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:51:40 INFO - Running setup.py install for requests 11:51:41 INFO - Running setup.py install for docopt 11:51:41 INFO - Successfully installed blobuploader requests docopt 11:51:41 INFO - Cleaning up... 11:51:41 INFO - Return code: 0 11:51:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104b9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104baa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6d84dd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a39e00>, '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 0x1048a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a34b20>, '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.O74jjRcrll/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.DZceUXPfH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 11:51:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:51:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O74jjRcrll/Render', 11:51:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:41 INFO - 'HOME': '/Users/cltbld', 11:51:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:41 INFO - 'LOGNAME': 'cltbld', 11:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:41 INFO - 'MOZ_NO_REMOTE': '1', 11:51:41 INFO - 'NO_EM_RESTART': '1', 11:51:41 INFO - 'PAGER': '/bin/cat', 11:51:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:41 INFO - 'PWD': '/builds/slave/test', 11:51:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:41 INFO - 'SHELL': '/bin/bash', 11:51:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DZceUXPfH4/Listeners', 11:51:41 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 11:51:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:41 INFO - 'USER': 'cltbld', 11:51:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:41 INFO - 'XPC_FLAGS': '0x0', 11:51:41 INFO - 'XPC_SERVICE_NAME': '0', 11:51:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:41 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-BZtmf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:41 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-ycCyfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:41 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-mOYUhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:41 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-ABbsGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:41 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-r5SBP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:42 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-o3nVk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:42 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Hg_mMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:42 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-okmlrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:42 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Nnl6pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:42 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-NlbG9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:42 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-ifh_ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:42 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-acwSco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:42 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-iZbZYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:42 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-179uX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:42 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-AMpn2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:43 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-EdcWIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:43 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-g0qTvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:51:43 INFO - Running setup.py install for manifestparser 11:51:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:51:43 INFO - Running setup.py install for mozcrash 11:51:43 INFO - Running setup.py install for mozdebug 11:51:43 INFO - Running setup.py install for mozdevice 11:51:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:51:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:51:43 INFO - Running setup.py install for mozfile 11:51:44 INFO - Running setup.py install for mozhttpd 11:51:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:51:44 INFO - Running setup.py install for mozinfo 11:51:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:51:44 INFO - Running setup.py install for mozInstall 11:51:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:51:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:51:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:51:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:51:44 INFO - Running setup.py install for mozleak 11:51:44 INFO - Running setup.py install for mozlog 11:51:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:51:44 INFO - Running setup.py install for moznetwork 11:51:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:51:44 INFO - Running setup.py install for mozprocess 11:51:45 INFO - Running setup.py install for mozprofile 11:51:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:51:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:51:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:51:45 INFO - Running setup.py install for mozrunner 11:51:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:51:45 INFO - Running setup.py install for mozscreenshot 11:51:45 INFO - Running setup.py install for moztest 11:51:45 INFO - Running setup.py install for mozversion 11:51:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:51:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:51:45 INFO - Cleaning up... 11:51:45 INFO - Return code: 0 11:51:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104b9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104baa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6d84dd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a39e00>, '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 0x1048a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a34b20>, '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.O74jjRcrll/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.DZceUXPfH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 11:51:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:51:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O74jjRcrll/Render', 11:51:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:45 INFO - 'HOME': '/Users/cltbld', 11:51:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:45 INFO - 'LOGNAME': 'cltbld', 11:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:45 INFO - 'MOZ_NO_REMOTE': '1', 11:51:45 INFO - 'NO_EM_RESTART': '1', 11:51:45 INFO - 'PAGER': '/bin/cat', 11:51:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:45 INFO - 'PWD': '/builds/slave/test', 11:51:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:45 INFO - 'SHELL': '/bin/bash', 11:51:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DZceUXPfH4/Listeners', 11:51:45 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 11:51:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:45 INFO - 'USER': 'cltbld', 11:51:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:45 INFO - 'XPC_FLAGS': '0x0', 11:51:45 INFO - 'XPC_SERVICE_NAME': '0', 11:51:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:46 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-CnivvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:46 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-4cvSac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:46 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-vq7dyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:46 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-LcTIPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:46 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Ug3Udz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:46 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Ejn9Dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:46 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-eiHHmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:46 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-rSMkAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:46 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-6JzvCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:47 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-j_gjGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:47 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-yjVK81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:47 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-WyzGkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:47 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-293Ufn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:47 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-0KQJq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:47 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-ip9oQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:47 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-fPIaSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:47 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-2Qyk0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:51:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:50 INFO - Downloading blessings-1.6.tar.gz 11:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:51:50 INFO - Installing collected packages: blessings 11:51:50 INFO - Running setup.py install for blessings 11:51:50 INFO - Successfully installed blessings 11:51:50 INFO - Cleaning up... 11:51:50 INFO - Return code: 0 11:51:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:50 INFO - Reading from file tmpfile_stdout 11:51:50 INFO - Current package versions: 11:51:50 INFO - blessings == 1.6 11:51:50 INFO - blobuploader == 1.2.4 11:51:50 INFO - docopt == 0.6.1 11:51:50 INFO - manifestparser == 1.1 11:51:50 INFO - mozInstall == 1.12 11:51:50 INFO - mozcrash == 0.17 11:51:50 INFO - mozdebug == 0.1 11:51:50 INFO - mozdevice == 0.48 11:51:50 INFO - mozfile == 1.2 11:51:50 INFO - mozhttpd == 0.7 11:51:50 INFO - mozinfo == 0.9 11:51:50 INFO - mozleak == 0.1 11:51:50 INFO - mozlog == 3.1 11:51:50 INFO - moznetwork == 0.27 11:51:50 INFO - mozprocess == 0.22 11:51:50 INFO - mozprofile == 0.28 11:51:50 INFO - mozrunner == 6.11 11:51:50 INFO - mozscreenshot == 0.1 11:51:50 INFO - mozsystemmonitor == 0.0 11:51:50 INFO - moztest == 0.7 11:51:50 INFO - mozversion == 1.4 11:51:50 INFO - psutil == 3.1.1 11:51:50 INFO - requests == 1.2.3 11:51:50 INFO - wsgiref == 0.1.2 11:51:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:50 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')]} 11:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:50 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')]} 11:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:50 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 0x104b9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104baa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6d84dd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a39e00>, '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 0x1048a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a34b20>, '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.O74jjRcrll/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.DZceUXPfH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 11:51:50 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 11:51:50 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 11:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O74jjRcrll/Render', 11:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:50 INFO - 'HOME': '/Users/cltbld', 11:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:50 INFO - 'LOGNAME': 'cltbld', 11:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:50 INFO - 'MOZ_NO_REMOTE': '1', 11:51:50 INFO - 'NO_EM_RESTART': '1', 11:51:50 INFO - 'PAGER': '/bin/cat', 11:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:50 INFO - 'PWD': '/builds/slave/test', 11:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:50 INFO - 'SHELL': '/bin/bash', 11:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DZceUXPfH4/Listeners', 11:51:50 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 11:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:50 INFO - 'USER': 'cltbld', 11:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:50 INFO - 'XPC_FLAGS': '0x0', 11:51:50 INFO - 'XPC_SERVICE_NAME': '0', 11:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:51:51 INFO - Cleaning up... 11:51:51 INFO - Return code: 0 11:51:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104b9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104baa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6d84dd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a39e00>, '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 0x1048a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a34b20>, '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.O74jjRcrll/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.DZceUXPfH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 11:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:51:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O74jjRcrll/Render', 11:51:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:51 INFO - 'HOME': '/Users/cltbld', 11:51:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:51 INFO - 'LOGNAME': 'cltbld', 11:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:51 INFO - 'MOZ_NO_REMOTE': '1', 11:51:51 INFO - 'NO_EM_RESTART': '1', 11:51:51 INFO - 'PAGER': '/bin/cat', 11:51:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:51 INFO - 'PWD': '/builds/slave/test', 11:51:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:51 INFO - 'SHELL': '/bin/bash', 11:51:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DZceUXPfH4/Listeners', 11:51:51 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 11:51:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:51 INFO - 'USER': 'cltbld', 11:51:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:51 INFO - 'XPC_FLAGS': '0x0', 11:51:51 INFO - 'XPC_SERVICE_NAME': '0', 11:51:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:51 INFO - Downloading/unpacking jsonschema 11:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:51:53 INFO - Downloading/unpacking functools32 (from jsonschema) 11:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:54 INFO - Downloading functools32-3.2.3-2.tar.gz 11:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:51:54 INFO - warning: no files found matching '*.txt' 11:51:54 INFO - no previously-included directories found matching 'build' 11:51:54 INFO - no previously-included directories found matching 'dist' 11:51:54 INFO - no previously-included directories found matching '.git*' 11:51:54 INFO - Installing collected packages: jsonschema, functools32 11:51:54 INFO - Running setup.py install for functools32 11:51:54 INFO - warning: no files found matching '*.txt' 11:51:54 INFO - no previously-included directories found matching 'build' 11:51:54 INFO - no previously-included directories found matching 'dist' 11:51:54 INFO - no previously-included directories found matching '.git*' 11:51:54 INFO - Successfully installed jsonschema functools32 11:51:54 INFO - Cleaning up... 11:51:54 INFO - Return code: 0 11:51:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104b9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104baa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6d84dd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a39e00>, '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 0x1048a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a34b20>, '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.O74jjRcrll/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.DZceUXPfH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 11:51:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:51:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O74jjRcrll/Render', 11:51:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:54 INFO - 'HOME': '/Users/cltbld', 11:51:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:54 INFO - 'LOGNAME': 'cltbld', 11:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:54 INFO - 'MOZ_NO_REMOTE': '1', 11:51:54 INFO - 'NO_EM_RESTART': '1', 11:51:54 INFO - 'PAGER': '/bin/cat', 11:51:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:54 INFO - 'PWD': '/builds/slave/test', 11:51:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:54 INFO - 'SHELL': '/bin/bash', 11:51:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DZceUXPfH4/Listeners', 11:51:54 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 11:51:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:54 INFO - 'USER': 'cltbld', 11:51:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:54 INFO - 'XPC_FLAGS': '0x0', 11:51:54 INFO - 'XPC_SERVICE_NAME': '0', 11:51:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:54 INFO - Downloading/unpacking flake8 11:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:51:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:51:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:51:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:51:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:51:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:51:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:51:58 INFO - no previously-included directories found matching 'docs/_build' 11:51:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:51:58 INFO - Running setup.py install for pep8 11:51:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:51:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:51:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:51:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:51:58 INFO - no previously-included directories found matching 'docs/_build' 11:51:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:51:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:51:58 INFO - Cleaning up... 11:51:59 INFO - Return code: 0 11:51:59 INFO - Running post-action listener: _resource_record_post_action 11:51:59 INFO - Running post-action listener: _start_resource_monitoring 11:51:59 INFO - Starting resource monitoring. 11:51:59 INFO - ##### 11:51:59 INFO - ##### Running install step. 11:51:59 INFO - ##### 11:51:59 INFO - Running pre-action listener: _resource_record_pre_action 11:51:59 INFO - Running main action method: install 11:51:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:59 INFO - Reading from file tmpfile_stdout 11:51:59 INFO - Detecting whether we're running mozinstall >=1.0... 11:51:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:51:59 INFO - Reading from file tmpfile_stdout 11:51:59 INFO - Output received: 11:51:59 INFO - Usage: mozinstall [options] installer 11:51:59 INFO - Options: 11:51:59 INFO - -h, --help show this help message and exit 11:51:59 INFO - -d DEST, --destination=DEST 11:51:59 INFO - Directory to install application into. [default: 11:51:59 INFO - "/builds/slave/test"] 11:51:59 INFO - --app=APP Application being installed. [default: firefox] 11:51:59 INFO - mkdir: /builds/slave/test/build/application 11:51:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:52:20 INFO - Reading from file tmpfile_stdout 11:52:20 INFO - Output received: 11:52:20 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:52:20 INFO - Running post-action listener: _resource_record_post_action 11:52:20 INFO - ##### 11:52:20 INFO - ##### Running run-tests step. 11:52:20 INFO - ##### 11:52:20 INFO - Running pre-action listener: _resource_record_pre_action 11:52:20 INFO - Running main action method: run_tests 11:52:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:52:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:52:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:52:20 INFO - 2016-07-15 11:52:20.984 screenresolution[1641:7417] starting screenresolution argv=screenresolution get 11:52:20 INFO - 2016-07-15 11:52:20.986 screenresolution[1641:7417] Display 0: 1600x1200x32@60 11:52:20 INFO - 2016-07-15 11:52:20.992 screenresolution[1642:7420] starting screenresolution argv=screenresolution list 11:52:20 INFO - Available Modes on Display 0 11:52:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:52:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:52:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:52:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:52:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:52:21 INFO - Intel Iris: 11:52:21 INFO - Chipset Model: Intel Iris 11:52:21 INFO - Type: GPU 11:52:21 INFO - Bus: Built-In 11:52:21 INFO - VRAM (Dynamic, Max): 1536 MB 11:52:21 INFO - Vendor: Intel (0x8086) 11:52:21 INFO - Device ID: 0x0a2e 11:52:21 INFO - Revision ID: 0x0009 11:52:21 INFO - Displays: 11:52:21 INFO - Display: 11:52:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:52:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:52:21 INFO - Display Serial Number: 1600x1200 60 11:52:21 INFO - Main Display: Yes 11:52:21 INFO - Mirror: Off 11:52:21 INFO - Online: Yes 11:52:21 INFO - Rotation: Supported 11:52:21 INFO - Return code: 0 11:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:52:21 INFO - Python 2.7.3 11:52:21 INFO - Return code: 0 11:52:21 INFO - grabbing minidump binary from tooltool 11:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a39e00>, '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 0x1048a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a34b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:52:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:52:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:52:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:52:21 INFO - Return code: 0 11:52:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:52:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:52:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:52:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:52:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:52:22 INFO - Return code: 0 11:52:22 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--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 11:52:22 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 http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0107 --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 11:52:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O74jjRcrll/Render', 11:52:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:22 INFO - 'HOME': '/Users/cltbld', 11:52:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:22 INFO - 'LOGNAME': 'cltbld', 11:52:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:52:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:22 INFO - 'MOZ_NO_REMOTE': '1', 11:52:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:52:22 INFO - 'NO_EM_RESTART': '1', 11:52:22 INFO - 'PAGER': '/bin/cat', 11:52:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:22 INFO - 'PWD': '/builds/slave/test', 11:52:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:52:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:22 INFO - 'SHELL': '/bin/bash', 11:52:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DZceUXPfH4/Listeners', 11:52:22 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 11:52:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:22 INFO - 'USER': 'cltbld', 11:52:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:22 INFO - 'XPC_FLAGS': '0x0', 11:52:22 INFO - 'XPC_SERVICE_NAME': '0', 11:52:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:22 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--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 11:52:22 INFO - mozversion application_buildid: 20160712072157 11:52:22 INFO - mozversion application_changeset: 0f717e101c78709aa6e5b0c29826c856a20d388b 11:52:22 INFO - mozversion application_display_name: Firefox 11:52:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:52:22 INFO - mozversion application_name: Firefox 11:52:22 INFO - mozversion application_remotingname: firefox 11:52:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:52:22 INFO - mozversion application_vendor: Mozilla 11:52:22 INFO - mozversion application_version: 48.0 11:52:22 INFO - mozversion platform_buildid: 20160712072157 11:52:22 INFO - mozversion platform_changeset: 0f717e101c78709aa6e5b0c29826c856a20d388b 11:52:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:52:22 INFO - mozversion platform_version: 48.0 11:52:22 INFO - using testdate: 1468608742 11:52:22 INFO - actual date: 1468608742 11:52:22 INFO - starting webserver on 'localhost:49279' 11:52:22 INFO - SUITE-START | Running 2 tests 11:52:22 INFO - TEST-START | dromaeo_css 11:52:22 INFO - operating with platform_type : mac_ 11:52:22 INFO - Initialising browser for dromaeo_css test... 11:52:22 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpbXxPKX/profile http://localhost:49279/getInfo.html) 11:52:24 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 11:52:24 INFO - PROCESS | 1660 | colorDepth:24 11:52:24 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 11:52:24 INFO - PROCESS | 1660 | __metrics 11:52:25 INFO - PROCESS | 1660 | 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:52:25 ERROR - PROCESS | 1660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:52:25 INFO - TEST-INFO | 1660: exit 0 11:52:25 INFO - Browser initialized. 11:52:25 INFO - Running cycle 1/1 for dromaeo_css test... 11:52:25 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpbXxPKX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:52:37 INFO - PROCESS | 1663 | RSS: Main: 161497088 11:52:37 INFO - PROCESS | 1663 | 11:53:28 INFO - PROCESS | 1663 | 1468608808911 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] 11:55:38 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 11:55:40 INFO - PROCESS | 1663 | RSS: Main: 291885056 11:55:40 INFO - PROCESS | 1663 | 11:58:42 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 11:58:43 INFO - PROCESS | 1663 | RSS: Main: 299991040 11:58:43 INFO - PROCESS | 1663 | 12:01:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 12:01:46 INFO - PROCESS | 1663 | RSS: Main: 304447488 12:01:46 INFO - PROCESS | 1663 | 12:04:48 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 12:04:48 INFO - PROCESS | 1663 | RSS: Main: 305307648 12:04:48 INFO - PROCESS | 1663 | 12:07:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 12:07:52 INFO - PROCESS | 1663 | RSS: Main: 272822272 12:07:52 INFO - PROCESS | 1663 | 12:10:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 12:10:55 INFO - PROCESS | 1663 | RSS: Main: 307216384 12:10:55 INFO - PROCESS | 1663 | 12:10:55 INFO - PROCESS | 1663 | __start_tp_report 12:10:55 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 12:10:55 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 12:10:55 INFO - PROCESS | 1663 | |i|pagename|runs| 12:10:55 INFO - PROCESS | 1663 | |0;dojo.html;3517.103138699631;3634.3639863023973;3648.6533779290958;3658.231771328021;3717.758345707529;5899.997000509913;6037.396260373966;6049.879002419949;6056.273247210341;6083;5949.524038076955;6073.665948372838;6100.969495152518;6114.694265286729;6130.3256641769485;5356.4107948125675;5395.919061214095;5453.890922181554;5473.917891231635;5526.41972592878;5449.155380915945;5493.478119578634;5498.367687715904;5505.174223866432;5520.751566179511;5326.307580014612;5367.141257398817;5384.542313903323;5408.999335123015;5498.697571633558;5484.890302193934;5501.449855014506;5518.034343989826;5521.861953451155;5587.720613969285;5304.708241046741;5374.435684253175;5404.7838086476495;5409.97210529998;5429.131338985783;5801.738921748489;5815.418458154193;5931;5974.522038236931;5980.940190598082;6336.303006669263;6339.619622822645;6344.270408902943;6354.2692590352235;6378.362163783631;6351.4283714465455;6429.067785171124;6471.417572418505;6491;6505;6107.083937409379;6154.938450615526;6177.722002509898;6210.7515699372425;6212.409821066992;6573.046908198285;6589.341065893373;6611.107500487373;6611.371919667624;6615.867682646416;6202.968985155046;6231.4391704746795;6271.090691849657;6276.466500347522;6297.685115744194;5339.5728341732565;6437.645929473831;6448.451881590117;6452.257990331078;6467.870642587216;5288.9735551322;6249.375062493714;6293.937060629427;6316.842078948063;6332.398422149889;6210.192674952317;6284.811455656338;6286.277078135981;6322.083297921776;6336.936630633634;5069.44236134025;5115.411727651293;5138.460461651547;5142.339724773428;5151.613628977767;4617.353570500132;4634.582887540138;4640.767961601907;4651.62786977041;4670.6497012724185;5992.981193197167;6158.7228574714245;6162.661053642093;6167.321594624587;6181.629102253789;5811.244538210006;6341.682915854189;6421.74313027483;6521.217453905561;6527.379898909596;6093.69531523422;6121.234845644294;6128.448439640454;6145.631262124287;6145.9692701536205;5575.358833734092;5596.244506991586;5640.097584386561;5660.179274005246;5662.094064949588;5914.378990205966;6602.933970660232;6621.702023408958;6721.798346049529;6732.730690772314;6455.935440645533;6473.546851720334;6489.415952564292;6490.7079181436;6513.316101809241;6735.764248251287;6739.05653208561;6740.66296685154;6742.764003259862;6745.258021617717;6192.845178870564;6204.81385558434;6313.90529142054;6322.146510221245;6324.209473815773;6410.519211059096;6426.678666066771;6437.098806167047;6440.581362211441;6446.129772480655;5325.201219817059;6209.96895015522;6246.781362652286;6259.467945224706;6273.090401891609;6191.535634827496;6197.132401463708;6247.5939063960695;6266.091416744638;6270.561060725706;6244.188255526752;6262.843428914313;6267.2792628848265;6269.341719119427;6271.216097987752;6253.499720022478;6258.155149054819;6271.216097987752;6272.18461599989;6291.6539590321145;6117.096718007557;6213.782517611862;6243.188385509855;6245.18812554365;6257 12:10:55 INFO - PROCESS | 1663 | |1;ext.html;525.214803868217;533.1975377057526;560.7904989148163;607.3167686352853;612.6875293600262;32983.50524742128;39696;40576.79711601445;40649.98375040625;40714.59285407145;44443;44924.77537612316;44968;45084.77457612716;45221.7738911305;9226.815463690722;9964.402135871853;10174.64388746394;10221;10221.182305415587;12110.636680899586;12399.628011159635;12410.751784964295;12414.317212553306;12417.689557761038;12120.81818772719;12226.266424014588;12230.63308100754;12237;12245.387730613478;12200.633980980585;12294;12295.631131066039;12298.139130260884;12309.815352769627;12041.819372709417;12153.817692734616;12162.087843411691;12164.08769342303;12175.634730958085;43229.78385108086;43613.78193109046;43674;43706.12587748227;43718;3314.635390107086;3391;3484.4773284007347;3722.3485889969147;3976.304146774303;29778.40443191124;30560.69439305623;30781.384372312652;30835.84582077075;31464.056078317688;2720.333518288032;2724.3053021479595;2762.5718013707706;2806.4106537626917;2818.788590855694;463007;465620;466809;467100;467332.9999999966;38028.429573556416;38823.80588097098;38896.41655375172;67945;68503;37677;38020.429693554615;38106.85679429622;38194;38205;16370.181490925406;16515.6696866062;16547.917260413622;16561.6687666246;16573.751393729104;12922.806157907638;13122.015848811378;13134.868651313556;13135.211887286603;13979.301034948212;8594.78513037179;8709.738707838775;8786.945566532057;8795.164459376349;8799.912000880036;3500.1074725944723;3570.767900086486;3572.821358932043;3582.2477279771538;3603.3694103531775;1039.9512959469832;1046.8482070099792;1061.879716898664;1078.5847448732295;1203.7652657731658;26961.730382696314;31564;32475.675243247264;32501.11856823266;32645.34709305848;982.5382070426888;1130.141092769501;1207.5773479282357;1246.1028059796931;1248.9875101248872;14938.402463901539;16843.83156168447;17274.265267318613;17367.739483907753;17710.645787084188;655753;772400;776737;777123;778250;63248.68375658184;63898.36101639017;64499.03251451232;64561.677191613744;64577.03134452987;1329.7672907241388;1397.5877116250933;1437.2813593203398;1551.8448155184392;1564.3820690827288;30550.694493054783;30814.845925770227;32628.673713263513;32969;32996.34007319792;58347.4165258342;59752.40247597468;60087.39912600993;63335.36664633479;63373.683131584046;603746;606568;606977;608121;608187;22790.886045569667;27608.171754847386;29347.266318342212;29460.410791783615;29715.851420742758;41972.160556789306;44801.55198447974;46340.536594633624;46567.03960573196;48536.5146348532;38017.2396552073;38219.61780382161;38397.424038638885;38475.807620961714;38910.6108938907;38582.80708596439;38819.86490743036;38825.805870970464;39110.608893911834;39558.80220598879;37676.869693909226;38509.807450962566;38775.41836872393;38938.6106138935;39005;32544.51183232206;32867.34265314728;33784;33854.661453386136;33922.8303858489;25180.74819251784;25301.114460993776;25415.618765718158;25849.224523264333;25965.480690386463 12:10:55 INFO - PROCESS | 1663 | |2;jquery.html;421.84180932150446;423.46008838730614;424.04378127322883;425.9318509038553;435.21443793951903;21045.473863153427;21078.89460552697;21791.346259612197;23229.535409291802;23237.535249295004;21883.562328753414;22010.119595216172;22127.44681382966;22132.336029919086;22320.55358892825;5839.620424672404;6108.083787431877;6150.138980542728;6154.169187159743;6164.630122192661;4399.406080179167;4498.797554110057;4598.701084429501;6056.545759068065;6183.350748171445;6721.63031033293;6753.425958793484;6762.087118239048;6763.086983257246;6787.524873258873;5811.883762324772;6129.785457508966;6723.226828914689;6740.595564266136;6742.932570674279;4109.91780164395;4277.230098582254;4289.378040184156;4289.592488713567;5984.401559844025;12205.511779528808;12474.376281185996;13124.934375328063;13326.533571324957;23301.76698233013;2151.7848215178515;2166.8374871884516;2216.0692509146197;2280.486890449652;2314.5718042162252;10319.329243599143;10560.683179504627;11210.943945280304;11290.830637540443;15094.547163585;1820.4265656318216;1833.7432759413693;1857.359211072178;1873.2881505028001;1909.0836398528784;109439;112905.87094129036;118397.40801296025;118760.40619796932;120472.39763801213;11760.823587646191;11783.587574434854;11928.701782455335;11930.582429614922;11959.880401195876;15122.924385378003;15139;15160.241987900561;15175.103112110986;15212.771808422882;9041.141091596288;9172.8624070639;9230.35387522867;9322.95338523303;9382;9166.908330916738;9190.218831399272;9214.216791572657;9219.677311294072;9314.44113353201;4765.8093676252565;4779.450363208275;4779.784909679072;4792.329073929653;4827.710337379698;1735.557432854614;1835.9449216523526;1992.4620352504742;2063.772984971652;2087.77034526202;939.2532936315646;964.9179819715403;976.2580438866371;997.2371136080903;1013.9138173255209;16639.918405303615;20390.69413958792;20948.685769713466;21171.259005934717;21248.468788280417;918.9816203675889;923.9953800230955;984.4142735072763;998.3810037776625;1050.2858056521638;10914.672559823219;11318.60384886525;11332;11343.489542970587;11354.26197297173;554740;654900;668824;674469;676634;132487.3375633135;132640;136232;140168;140250.2987485056;1048.895110488945;1081.9945900270607;1091.9727006824894;1094.950727217277;1099.3898386395467;18528.81471185271;18841;19266.747661401965;19267.132979015696;19596.020198989707;35278.82360588181;53085.20372194343;58488;59284.40715592789;60043;78103.60948195223;84010.57994710232;87164.5641771787;87616.56191719255;87800.56099719461;8125.8374832504205;8186.836263274582;8417.158284171534;8533.658653653783;8801.515916624647;9333.113354231336;12402.5659101931;13027.544035958696;13552.864471355555;13557.322133893069;11154.832677509681;11501.367424791717;11789.469473873525;11808.350540720343;11811.763764724828;10750.08624266946;10834.837477438003;11305;11524.769504609692;11615.76768464643;11694.649160525198;11742.119341049285;11930.940345298219;12021.75956480883;12211.816822747844;8495.830083398174;8607.741767746978;8609.741707748777;8630.611622476878;8827.984781750181;8720.43317184381;11633.069354451793;11665.941670291595;11866;11884.82172767392 12:10:55 INFO - PROCESS | 1663 | |3;mootools.html;1500.1824005916774;1635.419426103733;1655.6109314311138;1815.4644379907925;1966.6460037193299;8328.417010809246;9042.59308331125;9182.908170918288;9184.724458266246;9199.034101419355;8873.157050080248;9129.68046118386;9133.543322833848;9146.99383067862;9155.496447695374;2553.0426090216215;2583.8837252323597;2584.547704151766;2586.987065064672;2589.572720501115;2523;2577.497388009339;2589.443269697015;2590.870456477178;2593.688757349121;2538;2560.142352311978;2583.870806459679;2584.392667723093;2588.676415448069;2550.0564791027346;2573.9485210295784;2583.793296536282;2587.8188526803133;2588.4823035392997;2528.4311030018284;2562.0904578874606;2572.1126211457017;2577.935551611206;2582.992632873181;8911.841460610143;9199.218066464358;9200.907990920072;9229.538523073887;9242.86135707965;5684.914726279109;5831.912521312183;5867.442592953706;5915.763369465216;5942.5840191186635;3706.6664000240107;3807.4098514730263;3813.3707938190164;3838.692904567628;3869.090763670535;913.8355096082703;1068.1935138970105;1084.1868598551087;1086.6468397770757;1119.5242022140558;12356.505739770399;12457.75084498314;12555.874441255562;12563.057770667145;12626.053046021585;4844.8304309349005;4872.43966943806;4892.584130348889;4950.43070046942;4991.700497970133;9911.702648920544;9913.752156196153;9948.154406875352;9958.352707074017;9975.301728878909;5696.857578560569;5713.485786279171;5717.2281741965135;5729.083346664514;5729.828105156852;4573.108243892476;4600.631949444037;5080.644354895196;5258.237555554423;5265.341832270966;4057.14799892026;4085.59144085595;4139.985703502661;4161.895952601149;4173.603507666767;1268.8794564516356;1275.1392809853312;1275.929823859678;1282.5062350994933;1284.454107004538;927.2674587076134;938.7230766923774;951.2817822543935;969.8351280282369;1011.2314640872843;6065.6663883486835;6122.7857025004805;6192.969035154795;6210.937890621036;6220.409061139185;418.2304559610271;487.8707142607212;490.4874406245411;492.6108374384268;499.51796516361156;3464.6708562686504;3922.37242041272;4006.4991876015497;4053.148838743838;4129.938050929239;11088.889111108785;11589.536418543332;11597.826032609517;11615.36115513638;11625.76748465026;11295.03992160659;11300.321980681021;11314.264572802742;11337.603183888525;11399.772004559862;8797.252233560219;8899.777505562413;8910.376273660782;8910.420822646507;8924.018357980747;5847.327557330961;5960.701964901824;5982.162497250301;6145.569810113428;6237.282712488122;10053.748656283651;10127.088562029452;10202.38785672862;10227.539760710637;10230.48847557634;9881.50592470388;10020.599176032876;10033.698989030341;10245.897541024793;10257.948710256402;7081;7285.7814265572115;7603.125640551408;7788.961055194688;7924.009498812648;8655.48067115975;8690.739277821676;8702.347323950602;8715.694950676696;8727.869081963903;7645.235476452533;7712.614369281401;7784.92215077842;7868.763937081897;7881.684732610632;7569.432292577969;7595.848083038198;7668.1181664109345;7769.378449723896;7806.0632724073475;7269.491135620668;7415.073115860518;7420.703171873281;7421.628918554159;7431.591262480615;4892.535209155125;4977;5009.248612707977;5095.464976177448;5130.025295193901;5169.689818610896;5171.0394066474355;5239.4236633970995;5279.47205279469;5287.709175995357 12:10:55 INFO - PROCESS | 1663 | |4;prototype.html;332.50456819339183;335.7649645248325;342.13781271196575;345.4869518764636;348.74890079143006;6659.700313485892;6666.4000239978395;6690.2306234782955;6694.598324100557;6746.932530674691;6648.368405001529;6657.700403481843;6675.265720770712;6694.96652516738;6785.457163426926;4710.199266124759;4883.047805677894;4907.75461226939;4917.06575750608;4918.680285781431;4869.9269510957365;4930.926036109443;4939.67892087015;4971.676841005323;4997.600191984632;4896.657233993622;4908.97545512272;4939.506049395068;4942.258661200831;4953.207486802113;4714;4940.011997600476;4952.455229924705;4961.677490963076;4986;3428.674275943781;4086.979565102185;4225.619694227504;4234.91530169398;4248.192843359782;5240.685558866442;6270.372962703739;6319.304876463585;6366.490680745575;6394.872102557969;5879.882402351929;5898.292204935436;5900;5911.467967882912;5918.348981612019;5769.711514424304;7149.463790215755;7155.6064416457075;7157.4274058075225;7197.748078817269;3946.289667859784;4443.622292105143;4770.522947705202;4793.209120495114;4793.400824896888;7385.409167266659;7507.999999999945;7568.810779730496;7571.469997100206;7574.3183113520045;3910.569837317893;4705.153072446924;4714.504976977368;4717.174494463524;4723.173444647173;4815.568138090242;4816.54242846929;4821.2045012572535;4821.590164835958;4827.686200397034;5709.685967271756;5712.742926568314;5713.085906254979;5717.571182161355;5742.626729262584;6807.353301436356;7065.717371305193;7172.605506697182;7196.604186769673;7197.784066478014;1446.5081872163514;1607.549886031913;1634.8365163483556;1644.0382376309992;1662.7007138714905;844.6494704697604;1035.3206673166267;1056.815057364958;1057.931234469757;1061.4162210784039;5159.819406320761;5881;6225.782097626561;6696.8995465068065;6781.287964763727;7307.817304567428;7419.998300229508;7460.626968651546;7552.320291173821;7555.584442855586;6844.452443804584;6865.347791959756;6872.828179295558;6880.931190688029;6897.48268879826;3910.452536644815;3949.2299001694396;3950.2889479893897;3956.7032472564674;3962.2867883781196;7550.848983020309;7859.960700196577;7861.960690196627;7866.724664636825;7887.566183859943;7657.655405506765;7717.922820771832;7719.11230208522;7726.304632583095;7757.146713861471;7825.686972521035;7834.451588388872;7850.568218748023;7855.4893931895385;7879.763607091796;7441.516301440389;7451.701931922662;7454.180040195466;7465.365443937326;7501.699932002659;7042.084529011196;7392.408607311295;7414;7421.962890185515;7441.3674837637245;6335.841603959938;7875.251851074138;7920;7930.56381898978;7936.920630793618;3815.2369526094335;4754.025424787841;4764.309175169512;4764.404449443819;4769.66612337133;7493.887591686238;7504;7517.473776835569;7520.511166774142;7529.924700752922;6910.930890691029;7149.356557909813;7194.280571942764;7262.419006479575;7280.890786638311;7187.928120718726;7229.132504099542;7243;7249.637518124178;7267.200607933018;7085.539439936388;7093.864981602918;7094.787156385317;7106.964465177641;7136.571805691675;6896;7198.71205151788;7218.422526197996;7242.239564845615;7252.166000909963;6780.627065511247;6919.7232110715;6997.440204783707;7031.929680703128;7041.4014808739785 12:10:55 INFO - PROCESS | 1663 | |5;yui.html;789.1674283630767;798.5847359373126;801.8877357169994;805.53681633061;807.1283014344508;15478.690426191484;15546.144962027083;15813.288402021923;15842.683146337067;15856.127912964797;14787.669109780118;14855.7028859423;14872.47946321879;14886.776698349533;14892.032017918827;792.2948575767557;813.5932033983008;962.7448726087592;976.8778902637171;976.9706908792712;975.0931633580767;975.6536429567508;979.9853002204973;980.206033113177;981.2444417798291;822.198356602314;1030.5723124903157;1032.4166845732175;1033.9534720937538;1037.0873631204568;1002.5087707023579;1036.5491011410022;1039.3348257115451;1039.6309310194847;1042.687193841852;781.2851241114373;781.6677911887482;783.5768684910141;784.7214238945149;786.1470304719386;15659.843401565953;15706.293216805157;15716.842831571767;15749.921250393789;15769.896107272496;12995.415206315643;13052.934735326358;13265.27041012744;13485.528006519724;13500;10198.949005255;10366.06705396518;10399.064084232456;10695.946520267427;10823.83764243537;3558.09268636496;3598.1904071583685;3599.0102721751464;3656.0859785053735;3813.7902415367143;78170.82743758848;78240;78510;80280.59859700664;80691.5965420175;9755.365901216399;9841.557129929028;9853.261005424622;9958.203343732484;10080.899191007997;21084.47288817761;21290.893545532173;21324;21545.89227053886;23082.884585576965;7706.460547761715;7715.035620547432;7813.726519571787;7817.726379576688;8045.637946292431;4284.143171365739;4307.095509942885;4318.3090705486975;4391.055922976511;4579.5878370946775;3691.427828686504;3760.9657344230554;3768.4724138620613;3768.717346199046;3770.792606406619;673.1148539670318;681.1145510835894;705.1679018757812;724.398749038297;726.8219286274897;446.75875027485444;520.7448350308398;572.567711377907;638.4158494977137;644.136856612142;8305.95847020761;8495.27790137833;8509.489430634181;8655.437396569328;8668.826623467496;559.3651205881354;611.8959776837949;616.5191150902303;629.5844742469948;635.1742734445295;4001.139754952699;4014;4047.352423612208;4078.0620457294394;4153.06556024892;95450;95666.52166739122;96808;96939.18364897987;97800.51099744455;84206.57896710477;84483.5775821117;85923.14076859152;86364;86461;66337.66831165813;73031.63484182545;74166.88749668759;74267;74593.88109178367;8555.828883422173;8685.305175585812;8693.869591956;8804.427712198687;8909.287257019552;46470.767646161556;47969.5203047979;49990.75004624954;50268;50904.74547627238;65766;68709.86834579225;70187;70306.64846675734;71221.28778712354;10995.34027958325;11201.103911687209;11277.041451476716;11452.312861228353;11714.589989350332;11875.228110172811;12127.757444850877;12147.878521214674;12347.506099756269;12557.748845022865;11614.825777613512;11741.002014828493;11808.940955295513;11828.526858925547;12114.15200935926;11455.198136130392;11544.769104618028;11720.179587429138;12283.017358611469;12471.688207794878;11236.438178091226;11389.772204556028;11413;11559.826602601135;12306.630801075982;9638.084381983701;9770.36492627977;10050.899491004997;10055.798884022131;10370.533326000197;9644.228461722905;10003.249756268455;10053.447060411747;10115.14021308197;10254.53854576531 12:10:55 INFO - PROCESS | 1663 | __end_tp_report 12:10:55 INFO - PROCESS | 1663 | __start_cc_report 12:10:55 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1212 12:10:55 INFO - PROCESS | 1663 | __end_cc_report 12:10:55 INFO - PROCESS | 1663 | __startTimestamp1468609855368__endTimestamp 12:10:55 INFO - PROCESS | 1663 | 12:10:55 INFO - PROCESS | 1663 | ------- Summary: start ------- 12:10:55 INFO - PROCESS | 1663 | Number of tests: 6 12:10:55 INFO - PROCESS | 1663 | 12:10:55 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5963.24 Median:6202.97 stddev:634.18 (10.2%) stddev-sans-first:606.40 12:10:55 INFO - PROCESS | 1663 | Values: 3517.1 3634.4 3648.7 3658.2 3717.8 5900.0 6037.4 6049.9 6056.3 6083.0 5949.5 6073.7 6101.0 6114.7 6130.3 5356.4 5395.9 5453.9 5473.9 5526.4 5449.2 5493.5 5498.4 5505.2 5520.8 5326.3 5367.1 5384.5 5409.0 5498.7 5484.9 5501.4 5518.0 5521.9 5587.7 5304.7 5374.4 5404.8 5410.0 5429.1 5801.7 5815.4 5931.0 5974.5 5980.9 6336.3 6339.6 6344.3 6354.3 6378.4 6351.4 6429.1 6471.4 6491.0 6505.0 6107.1 6154.9 6177.7 6210.8 6212.4 6573.0 6589.3 6611.1 6611.4 6615.9 6203.0 6231.4 6271.1 6276.5 6297.7 5339.6 6437.6 6448.5 6452.3 6467.9 5289.0 6249.4 6293.9 6316.8 6332.4 6210.2 6284.8 6286.3 6322.1 6336.9 5069.4 5115.4 5138.5 5142.3 5151.6 4617.4 4634.6 4640.8 4651.6 4670.6 5993.0 6158.7 6162.7 6167.3 6181.6 5811.2 6341.7 6421.7 6521.2 6527.4 6093.7 6121.2 6128.4 6145.6 6146.0 5575.4 5596.2 5640.1 5660.2 5662.1 5914.4 6602.9 6621.7 6721.8 6732.7 6455.9 6473.5 6489.4 6490.7 6513.3 6735.8 6739.1 6740.7 6742.8 6745.3 6192.8 6204.8 6313.9 6322.1 6324.2 6410.5 6426.7 6437.1 6440.6 6446.1 5325.2 6210.0 6246.8 6259.5 6273.1 6191.5 6197.1 6247.6 6266.1 6270.6 6244.2 6262.8 6267.3 6269.3 6271.2 6253.5 6258.2 6271.2 6272.2 6291.7 6117.1 6213.8 6243.2 6245.2 6257.0 12:10:55 INFO - PROCESS | 1663 | 12:10:55 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:73236.19 Median:3492.29 stddev:166391.10 (4764.5%) stddev-sans-first:166768.31 12:10:55 INFO - PROCESS | 1663 | Values: 525.2 533.2 560.8 607.3 612.7 32983.5 39696.0 40576.8 40650.0 40714.6 44443.0 44924.8 44968.0 45084.8 45221.8 9226.8 9964.4 10174.6 10221.0 10221.2 12110.6 12399.6 12410.8 12414.3 12417.7 12120.8 12226.3 12230.6 12237.0 12245.4 12200.6 12294.0 12295.6 12298.1 12309.8 12041.8 12153.8 12162.1 12164.1 12175.6 43229.8 43613.8 43674.0 43706.1 43718.0 3314.6 3391.0 3484.5 3722.3 3976.3 29778.4 30560.7 30781.4 30835.8 31464.1 2720.3 2724.3 2762.6 2806.4 2818.8 463007.0 465620.0 466809.0 467100.0 467333.0 38028.4 38823.8 38896.4 67945.0 68503.0 37677.0 38020.4 38106.9 38194.0 38205.0 16370.2 16515.7 16547.9 16561.7 16573.8 12922.8 13122.0 13134.9 13135.2 13979.3 8594.8 8709.7 8786.9 8795.2 8799.9 3500.1 3570.8 3572.8 3582.2 3603.4 1040.0 1046.8 1061.9 1078.6 1203.8 26961.7 31564.0 32475.7 32501.1 32645.3 982.5 1130.1 1207.6 1246.1 1249.0 14938.4 16843.8 17274.3 17367.7 17710.6 655753.0 772400.0 776737.0 777123.0 778250.0 63248.7 63898.4 64499.0 64561.7 64577.0 1329.8 1397.6 1437.3 1551.8 1564.4 30550.7 30814.8 32628.7 32969.0 32996.3 58347.4 59752.4 60087.4 63335.4 63373.7 603746.0 606568.0 606977.0 608121.0 608187.0 22790.9 27608.2 29347.3 29460.4 29715.9 41972.2 44801.6 46340.5 46567.0 48536.5 38017.2 38219.6 38397.4 38475.8 38910.6 38582.8 38819.9 38825.8 39110.6 39558.8 37676.9 38509.8 38775.4 38938.6 39005.0 32544.5 32867.3 33784.0 33854.7 33922.8 25180.7 25301.1 25415.6 25849.2 25965.5 12:10:55 INFO - PROCESS | 1663 | 12:10:55 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:36714.27 Median:22068.78 stddev:107909.94 (489.0%) stddev-sans-first:108178.24 12:10:55 INFO - PROCESS | 1663 | Values: 421.8 423.5 424.0 425.9 435.2 21045.5 21078.9 21791.3 23229.5 23237.5 21883.6 22010.1 22127.4 22132.3 22320.6 5839.6 6108.1 6150.1 6154.2 6164.6 4399.4 4498.8 4598.7 6056.5 6183.4 6721.6 6753.4 6762.1 6763.1 6787.5 5811.9 6129.8 6723.2 6740.6 6742.9 4109.9 4277.2 4289.4 4289.6 5984.4 12205.5 12474.4 13124.9 13326.5 23301.8 2151.8 2166.8 2216.1 2280.5 2314.6 10319.3 10560.7 11210.9 11290.8 15094.5 1820.4 1833.7 1857.4 1873.3 1909.1 109439.0 112905.9 118397.4 118760.4 120472.4 11760.8 11783.6 11928.7 11930.6 11959.9 15122.9 15139.0 15160.2 15175.1 15212.8 9041.1 9172.9 9230.4 9323.0 9382.0 9166.9 9190.2 9214.2 9219.7 9314.4 4765.8 4779.5 4779.8 4792.3 4827.7 1735.6 1835.9 1992.5 2063.8 2087.8 939.3 964.9 976.3 997.2 1013.9 16639.9 20390.7 20948.7 21171.3 21248.5 919.0 924.0 984.4 998.4 1050.3 10914.7 11318.6 11332.0 11343.5 11354.3 554740.0 654900.0 668824.0 674469.0 676634.0 132487.3 132640.0 136232.0 140168.0 140250.3 1048.9 1082.0 1092.0 1095.0 1099.4 18528.8 18841.0 19266.7 19267.1 19596.0 35278.8 53085.2 58488.0 59284.4 60043.0 78103.6 84010.6 87164.6 87616.6 87800.6 8125.8 8186.8 8417.2 8533.7 8801.5 9333.1 12402.6 13027.5 13552.9 13557.3 11154.8 11501.4 11789.5 11808.4 11811.8 10750.1 10834.8 11305.0 11524.8 11615.8 11694.6 11742.1 11930.9 12021.8 12211.8 8495.8 8607.7 8609.7 8630.6 8828.0 8720.4 11633.1 11665.9 11866.0 11884.8 12:10:55 INFO - PROCESS | 1663 | 12:10:55 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5967.40 Median:2738.26 stddev:3350.81 (122.4%) stddev-sans-first:3343.39 12:10:55 INFO - PROCESS | 1663 | Values: 1500.2 1635.4 1655.6 1815.5 1966.6 8328.4 9042.6 9182.9 9184.7 9199.0 8873.2 9129.7 9133.5 9147.0 9155.5 2553.0 2583.9 2584.5 2587.0 2589.6 2523.0 2577.5 2589.4 2590.9 2593.7 2538.0 2560.1 2583.9 2584.4 2588.7 2550.1 2573.9 2583.8 2587.8 2588.5 2528.4 2562.1 2572.1 2577.9 2583.0 8911.8 9199.2 9200.9 9229.5 9242.9 5684.9 5831.9 5867.4 5915.8 5942.6 3706.7 3807.4 3813.4 3838.7 3869.1 913.8 1068.2 1084.2 1086.6 1119.5 12356.5 12457.8 12555.9 12563.1 12626.1 4844.8 4872.4 4892.6 4950.4 4991.7 9911.7 9913.8 9948.2 9958.4 9975.3 5696.9 5713.5 5717.2 5729.1 5729.8 4573.1 4600.6 5080.6 5258.2 5265.3 4057.1 4085.6 4140.0 4161.9 4173.6 1268.9 1275.1 1275.9 1282.5 1284.5 927.3 938.7 951.3 969.8 1011.2 6065.7 6122.8 6193.0 6210.9 6220.4 418.2 487.9 490.5 492.6 499.5 3464.7 3922.4 4006.5 4053.1 4129.9 11088.9 11589.5 11597.8 11615.4 11625.8 11295.0 11300.3 11314.3 11337.6 11399.8 8797.3 8899.8 8910.4 8910.4 8924.0 5847.3 5960.7 5982.2 6145.6 6237.3 10053.7 10127.1 10202.4 10227.5 10230.5 9881.5 10020.6 10033.7 10245.9 10257.9 7081.0 7285.8 7603.1 7789.0 7924.0 8655.5 8690.7 8702.3 8715.7 8727.9 7645.2 7712.6 7784.9 7868.8 7881.7 7569.4 7595.8 7668.1 7769.4 7806.1 7269.5 7415.1 7420.7 7421.6 7431.6 4892.5 4977.0 5009.2 5095.5 5130.0 5169.7 5171.0 5239.4 5279.5 5287.7 12:10:55 INFO - PROCESS | 1663 | 12:10:55 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5863.60 Median:6694.78 stddev:1912.18 (28.6%) stddev-sans-first:1871.93 12:10:55 INFO - PROCESS | 1663 | Values: 332.5 335.8 342.1 345.5 348.7 6659.7 6666.4 6690.2 6694.6 6746.9 6648.4 6657.7 6675.3 6695.0 6785.5 4710.2 4883.0 4907.8 4917.1 4918.7 4869.9 4930.9 4939.7 4971.7 4997.6 4896.7 4909.0 4939.5 4942.3 4953.2 4714.0 4940.0 4952.5 4961.7 4986.0 3428.7 4087.0 4225.6 4234.9 4248.2 5240.7 6270.4 6319.3 6366.5 6394.9 5879.9 5898.3 5900.0 5911.5 5918.3 5769.7 7149.5 7155.6 7157.4 7197.7 3946.3 4443.6 4770.5 4793.2 4793.4 7385.4 7508.0 7568.8 7571.5 7574.3 3910.6 4705.2 4714.5 4717.2 4723.2 4815.6 4816.5 4821.2 4821.6 4827.7 5709.7 5712.7 5713.1 5717.6 5742.6 6807.4 7065.7 7172.6 7196.6 7197.8 1446.5 1607.5 1634.8 1644.0 1662.7 844.6 1035.3 1056.8 1057.9 1061.4 5159.8 5881.0 6225.8 6696.9 6781.3 7307.8 7420.0 7460.6 7552.3 7555.6 6844.5 6865.3 6872.8 6880.9 6897.5 3910.5 3949.2 3950.3 3956.7 3962.3 7550.8 7860.0 7862.0 7866.7 7887.6 7657.7 7717.9 7719.1 7726.3 7757.1 7825.7 7834.5 7850.6 7855.5 7879.8 7441.5 7451.7 7454.2 7465.4 7501.7 7042.1 7392.4 7414.0 7422.0 7441.4 6335.8 7875.3 7920.0 7930.6 7936.9 3815.2 4754.0 4764.3 4764.4 4769.7 7493.9 7504.0 7517.5 7520.5 7529.9 6910.9 7149.4 7194.3 7262.4 7280.9 7187.9 7229.1 7243.0 7249.6 7267.2 7085.5 7093.9 7094.8 7107.0 7136.6 6896.0 7198.7 7218.4 7242.2 7252.2 6780.6 6919.7 6997.4 7031.9 7041.4 12:10:55 INFO - PROCESS | 1663 | 12:10:55 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18909.68 Median:2418.91 stddev:26554.19 (1097.8%) stddev-sans-first:26593.82 12:10:55 INFO - PROCESS | 1663 | Values: 789.2 798.6 801.9 805.5 807.1 15478.7 15546.1 15813.3 15842.7 15856.1 14787.7 14855.7 14872.5 14886.8 14892.0 792.3 813.6 962.7 976.9 977.0 975.1 975.7 980.0 980.2 981.2 822.2 1030.6 1032.4 1034.0 1037.1 1002.5 1036.5 1039.3 1039.6 1042.7 781.3 781.7 783.6 784.7 786.1 15659.8 15706.3 15716.8 15749.9 15769.9 12995.4 13052.9 13265.3 13485.5 13500.0 10198.9 10366.1 10399.1 10695.9 10823.8 3558.1 3598.2 3599.0 3656.1 3813.8 78170.8 78240.0 78510.0 80280.6 80691.6 9755.4 9841.6 9853.3 9958.2 10080.9 21084.5 21290.9 21324.0 21545.9 23082.9 7706.5 7715.0 7813.7 7817.7 8045.6 4284.1 4307.1 4318.3 4391.1 4579.6 3691.4 3761.0 3768.5 3768.7 3770.8 673.1 681.1 705.2 724.4 726.8 446.8 520.7 572.6 638.4 644.1 8306.0 8495.3 8509.5 8655.4 8668.8 559.4 611.9 616.5 629.6 635.2 4001.1 4014.0 4047.4 4078.1 4153.1 95450.0 95666.5 96808.0 96939.2 97800.5 84206.6 84483.6 85923.1 86364.0 86461.0 66337.7 73031.6 74166.9 74267.0 74593.9 8555.8 8685.3 8693.9 8804.4 8909.3 46470.8 47969.5 49990.8 50268.0 50904.7 65766.0 68709.9 70187.0 70306.6 71221.3 10995.3 11201.1 11277.0 11452.3 11714.6 11875.2 12127.8 12147.9 12347.5 12557.7 11614.8 11741.0 11808.9 11828.5 12114.2 11455.2 11544.8 11720.2 12283.0 12471.7 11236.4 11389.8 11413.0 11559.8 12306.6 9638.1 9770.4 10050.9 10055.8 10370.5 9644.2 10003.2 10053.4 10115.1 10254.5 12:10:55 INFO - PROCESS | 1663 | -------- Summary: end -------- 12:10:55 INFO - PROCESS | 1663 | 12:10:55 INFO - TEST-INFO | 1663: exit 0 12:10:55 INFO - TEST-OK | dromaeo_css | took 1113264ms 12:10:55 INFO - TEST-START | kraken 12:10:55 INFO - operating with platform_type : mac_ 12:10:55 INFO - Initialising browser for kraken test... 12:10:55 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpQv8ieV/profile http://localhost:49279/getInfo.html) 12:10:57 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 12:10:57 INFO - PROCESS | 1673 | colorDepth:24 12:10:57 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 12:10:57 INFO - PROCESS | 1673 | __metrics 12:10:57 INFO - PROCESS | 1673 | 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" 12:10:57 ERROR - PROCESS | 1673 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:10:58 INFO - TEST-INFO | 1673: exit 0 12:10:58 INFO - Browser initialized. 12:10:58 INFO - Running cycle 1/1 for kraken test... 12:10:58 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpQv8ieV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:11:10 INFO - PROCESS | 1676 | RSS: Main: 161660928 12:11:10 INFO - PROCESS | 1676 | 12:11:12 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 12:11:13 INFO - PROCESS | 1676 | RSS: Main: 224198656 12:11:13 INFO - PROCESS | 1676 | 12:11:16 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 12:11:16 INFO - PROCESS | 1676 | RSS: Main: 239849472 12:11:16 INFO - PROCESS | 1676 | 12:11:20 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 12:11:20 INFO - PROCESS | 1676 | RSS: Main: 323850240 12:11:20 INFO - PROCESS | 1676 | 12:11:22 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 12:11:23 INFO - PROCESS | 1676 | RSS: Main: 229900288 12:11:23 INFO - PROCESS | 1676 | 12:11:25 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:11:25 INFO - PROCESS | 1676 | RSS: Main: 231022592 12:11:25 INFO - PROCESS | 1676 | 12:11:28 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 12:11:29 INFO - PROCESS | 1676 | RSS: Main: 267411456 12:11:29 INFO - PROCESS | 1676 | 12:11:32 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 12:11:32 INFO - PROCESS | 1676 | RSS: Main: 267898880 12:11:32 INFO - PROCESS | 1676 | 12:11:35 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 12:11:36 INFO - PROCESS | 1676 | RSS: Main: 267718656 12:11:36 INFO - PROCESS | 1676 | 12:11:37 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:11:38 INFO - PROCESS | 1676 | RSS: Main: 260304896 12:11:38 INFO - PROCESS | 1676 | 12:11:40 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:11:41 INFO - PROCESS | 1676 | RSS: Main: 267464704 12:11:41 INFO - PROCESS | 1676 | 12:11:43 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:11:43 INFO - PROCESS | 1676 | RSS: Main: 270962688 12:11:43 INFO - PROCESS | 1676 | 12:11:46 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:11:47 INFO - PROCESS | 1676 | RSS: Main: 278036480 12:11:47 INFO - PROCESS | 1676 | 12:11:49 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:11:50 INFO - PROCESS | 1676 | RSS: Main: 275243008 12:11:50 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 12:11:52 INFO - PROCESS | 1676 | RSS: Main: 335917056 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | __start_tp_report 12:11:52 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 12:11:52 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 12:11:52 INFO - PROCESS | 1676 | |i|pagename|runs| 12:11:52 INFO - PROCESS | 1676 | |0;ai-astar;112;114;121;111;112;111;115;113;114;135 12:11:52 INFO - PROCESS | 1676 | |1;audio-beat-detection;156;121;143;163;115;137;117;151;153;115 12:11:52 INFO - PROCESS | 1676 | |2;audio-dft;184;187;185;185;182;182;183;186;185;183 12:11:52 INFO - PROCESS | 1676 | |3;audio-fft;70;79;72;150;56;56;56;67;132;55 12:11:52 INFO - PROCESS | 1676 | |4;audio-oscillator;86;90;138;79;90;87;126;80;76;126 12:11:52 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;129;131;88;86;89;127;89;86;106;108 12:11:52 INFO - PROCESS | 1676 | |6;imaging-darkroom;93;92;92;92;93;93;93;92;92;92 12:11:52 INFO - PROCESS | 1676 | |7;imaging-desaturate;87;99;135;142;85;82;85;83;85;84 12:11:52 INFO - PROCESS | 1676 | |8;json-parse-financial;59;63;64;62;62;61;62;77;58;56 12:11:52 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;61;65;72;74;69;66;65;68;67;66 12:11:52 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;81;80;76;80;77;78;79;78;78;83 12:11:52 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;126;124;124;126;139;120;120;122;142;130 12:11:52 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;165;159;171;163;163;162;157;164;159;164 12:11:52 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;65;68;65;66;68;67;72;98;102;98 12:11:52 INFO - PROCESS | 1676 | __end_tp_report 12:11:52 INFO - PROCESS | 1676 | __start_cc_report 12:11:52 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1931 12:11:52 INFO - PROCESS | 1676 | __end_cc_report 12:11:52 INFO - PROCESS | 1676 | __startTimestamp1468609912533__endTimestamp 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | ------- Summary: start ------- 12:11:52 INFO - PROCESS | 1676 | Number of tests: 14 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:115.80 Median:114.00 stddev:7.35 (6.4%) stddev-sans-first:7.66 12:11:52 INFO - PROCESS | 1676 | Values: 112.0 114.0 121.0 111.0 112.0 111.0 115.0 113.0 114.0 135.0 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:147.00 stddev:18.71 (12.7%) stddev-sans-first:18.55 12:11:52 INFO - PROCESS | 1676 | Values: 156.0 121.0 143.0 163.0 115.0 137.0 117.0 151.0 153.0 115.0 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.00 stddev:1.69 (0.9%) stddev-sans-first:1.79 12:11:52 INFO - PROCESS | 1676 | Values: 184.0 187.0 185.0 185.0 182.0 182.0 183.0 186.0 185.0 183.0 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:79.30 Median:61.50 stddev:33.81 (55.0%) stddev-sans-first:35.69 12:11:52 INFO - PROCESS | 1676 | Values: 70.0 79.0 72.0 150.0 56.0 56.0 56.0 67.0 132.0 55.0 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:83.00 stddev:22.92 (27.6%) stddev-sans-first:23.91 12:11:52 INFO - PROCESS | 1676 | Values: 86.0 90.0 138.0 79.0 90.0 87.0 126.0 80.0 76.0 126.0 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:103.90 Median:86.00 stddev:19.02 (22.1%) stddev-sans-first:17.88 12:11:52 INFO - PROCESS | 1676 | Values: 129.0 131.0 88.0 86.0 89.0 127.0 89.0 86.0 106.0 108.0 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:92.40 Median:92.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 12:11:52 INFO - PROCESS | 1676 | Values: 93.0 92.0 92.0 92.0 93.0 93.0 93.0 92.0 92.0 92.0 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:85.00 stddev:22.59 (26.6%) stddev-sans-first:23.69 12:11:52 INFO - PROCESS | 1676 | Values: 87.0 99.0 135.0 142.0 85.0 82.0 85.0 83.0 85.0 84.0 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:62.00 stddev:5.68 (9.2%) stddev-sans-first:5.89 12:11:52 INFO - PROCESS | 1676 | Values: 59.0 63.0 64.0 62.0 62.0 61.0 62.0 77.0 58.0 56.0 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:3.71 (5.5%) stddev-sans-first:3.16 12:11:52 INFO - PROCESS | 1676 | Values: 61.0 65.0 72.0 74.0 69.0 66.0 65.0 68.0 67.0 66.0 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.50 stddev:2.05 (2.6%) stddev-sans-first:2.05 12:11:52 INFO - PROCESS | 1676 | Values: 81.0 80.0 76.0 80.0 77.0 78.0 79.0 78.0 78.0 83.0 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:126.00 stddev:7.60 (6.0%) stddev-sans-first:8.05 12:11:52 INFO - PROCESS | 1676 | Values: 126.0 124.0 124.0 126.0 139.0 120.0 120.0 122.0 142.0 130.0 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:163.50 stddev:3.92 (2.4%) stddev-sans-first:4.07 12:11:52 INFO - PROCESS | 1676 | Values: 165.0 159.0 171.0 163.0 163.0 162.0 157.0 164.0 159.0 164.0 12:11:52 INFO - PROCESS | 1676 | 12:11:52 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.90 Median:68.00 stddev:15.65 (23.0%) stddev-sans-first:15.99 12:11:52 INFO - PROCESS | 1676 | Values: 65.0 68.0 65.0 66.0 68.0 67.0 72.0 98.0 102.0 98.0 12:11:52 INFO - PROCESS | 1676 | -------- Summary: end -------- 12:11:52 INFO - PROCESS | 1676 | 12:11:53 INFO - TEST-INFO | 1676: exit 0 12:11:53 INFO - TEST-OK | kraken | took 57405ms 12:11:53 INFO - SUITE-END | took 1170s 12:11:53 INFO - Completed test suite (00:19:31) 12:11:53 INFO - javascript benchmark 12:11:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3517.103138699631, 3634.3639863023973, 3648.6533779290958, 3658.231771328021, 3717.758345707529, 5899.997000509913, 6037.396260373966, 6049.879002419949, 6056.273247210341, 6083.0, 5949.524038076955, 6073.665948372838, 6100.969495152518, 6114.694265286729, 6130.3256641769485, 5356.4107948125675, 5395.919061214095, 5453.890922181554, 5473.917891231635, 5526.41972592878, 5449.155380915945, 5493.478119578634, 5498.367687715904, 5505.174223866432, 5520.751566179511, 5326.307580014612, 5367.141257398817, 5384.542313903323, 5408.999335123015, 5498.697571633558, 5484.890302193934, 5501.449855014506, 5518.034343989826, 5521.861953451155, 5587.720613969285, 5304.708241046741, 5374.435684253175, 5404.7838086476495, 5409.97210529998, 5429.131338985783, 5801.738921748489, 5815.418458154193, 5931.0, 5974.522038236931, 5980.940190598082, 6336.303006669263, 6339.619622822645, 6344.270408902943, 6354.2692590352235, 6378.362163783631, 6351.4283714465455, 6429.067785171124, 6471.417572418505, 6491.0, 6505.0, 6107.083937409379, 6154.938450615526, 6177.722002509898, 6210.7515699372425, 6212.409821066992, 6573.046908198285, 6589.341065893373, 6611.107500487373, 6611.371919667624, 6615.867682646416, 6202.968985155046, 6231.4391704746795, 6271.090691849657, 6276.466500347522, 6297.685115744194, 5339.5728341732565, 6437.645929473831, 6448.451881590117, 6452.257990331078, 6467.870642587216, 5288.9735551322, 6249.375062493714, 6293.937060629427, 6316.842078948063, 6332.398422149889, 6210.192674952317, 6284.811455656338, 6286.277078135981, 6322.083297921776, 6336.936630633634, 5069.44236134025, 5115.411727651293, 5138.460461651547, 5142.339724773428, 5151.613628977767, 4617.353570500132, 4634.582887540138, 4640.767961601907, 4651.62786977041, 4670.6497012724185, 5992.981193197167, 6158.7228574714245, 6162.661053642093, 6167.321594624587, 6181.629102253789, 5811.244538210006, 6341.682915854189, 6421.74313027483, 6521.217453905561, 6527.379898909596, 6093.69531523422, 6121.234845644294, 6128.448439640454, 6145.631262124287, 6145.9692701536205, 5575.358833734092, 5596.244506991586, 5640.097584386561, 5660.179274005246, 5662.094064949588, 5914.378990205966, 6602.933970660232, 6621.702023408958, 6721.798346049529, 6732.730690772314, 6455.935440645533, 6473.546851720334, 6489.415952564292, 6490.7079181436, 6513.316101809241, 6735.764248251287, 6739.05653208561, 6740.66296685154, 6742.764003259862, 6745.258021617717, 6192.845178870564, 6204.81385558434, 6313.90529142054, 6322.146510221245, 6324.209473815773, 6410.519211059096, 6426.678666066771, 6437.098806167047, 6440.581362211441, 6446.129772480655, 5325.201219817059, 6209.96895015522, 6246.781362652286, 6259.467945224706, 6273.090401891609, 6191.535634827496, 6197.132401463708, 6247.5939063960695, 6266.091416744638, 6270.561060725706, 6244.188255526752, 6262.843428914313, 6267.2792628848265, 6269.341719119427, 6271.216097987752, 6253.499720022478, 6258.155149054819, 6271.216097987752, 6272.18461599989, 6291.6539590321145, 6117.096718007557, 6213.782517611862, 6243.188385509855, 6245.18812554365, 6257.0], "value": 5925.769370678409, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.214803868217, 533.1975377057526, 560.7904989148163, 607.3167686352853, 612.6875293600262, 32983.50524742128, 39696.0, 40576.79711601445, 40649.98375040625, 40714.59285407145, 44443.0, 44924.77537612316, 44968.0, 45084.77457612716, 45221.7738911305, 9226.815463690722, 9964.402135871853, 10174.64388746394, 10221.0, 10221.182305415587, 12110.636680899586, 12399.628011159635, 12410.751784964295, 12414.317212553306, 12417.689557761038, 12120.81818772719, 12226.266424014588, 12230.63308100754, 12237.0, 12245.387730613478, 12200.633980980585, 12294.0, 12295.631131066039, 12298.139130260884, 12309.815352769627, 12041.819372709417, 12153.817692734616, 12162.087843411691, 12164.08769342303, 12175.634730958085, 43229.78385108086, 43613.78193109046, 43674.0, 43706.12587748227, 43718.0, 3314.635390107086, 3391.0, 3484.4773284007347, 3722.3485889969147, 3976.304146774303, 29778.40443191124, 30560.69439305623, 30781.384372312652, 30835.84582077075, 31464.056078317688, 2720.333518288032, 2724.3053021479595, 2762.5718013707706, 2806.4106537626917, 2818.788590855694, 463007.0, 465620.0, 466809.0, 467100.0, 467332.9999999966, 38028.429573556416, 38823.80588097098, 38896.41655375172, 67945.0, 68503.0, 37677.0, 38020.429693554615, 38106.85679429622, 38194.0, 38205.0, 16370.181490925406, 16515.6696866062, 16547.917260413622, 16561.6687666246, 16573.751393729104, 12922.806157907638, 13122.015848811378, 13134.868651313556, 13135.211887286603, 13979.301034948212, 8594.78513037179, 8709.738707838775, 8786.945566532057, 8795.164459376349, 8799.912000880036, 3500.1074725944723, 3570.767900086486, 3572.821358932043, 3582.2477279771538, 3603.3694103531775, 1039.9512959469832, 1046.8482070099792, 1061.879716898664, 1078.5847448732295, 1203.7652657731658, 26961.730382696314, 31564.0, 32475.675243247264, 32501.11856823266, 32645.34709305848, 982.5382070426888, 1130.141092769501, 1207.5773479282357, 1246.1028059796931, 1248.9875101248872, 14938.402463901539, 16843.83156168447, 17274.265267318613, 17367.739483907753, 17710.645787084188, 655753.0, 772400.0, 776737.0, 777123.0, 778250.0, 63248.68375658184, 63898.36101639017, 64499.03251451232, 64561.677191613744, 64577.03134452987, 1329.7672907241388, 1397.5877116250933, 1437.2813593203398, 1551.8448155184392, 1564.3820690827288, 30550.694493054783, 30814.845925770227, 32628.673713263513, 32969.0, 32996.34007319792, 58347.4165258342, 59752.40247597468, 60087.39912600993, 63335.36664633479, 63373.683131584046, 603746.0, 606568.0, 606977.0, 608121.0, 608187.0, 22790.886045569667, 27608.171754847386, 29347.266318342212, 29460.410791783615, 29715.851420742758, 41972.160556789306, 44801.55198447974, 46340.536594633624, 46567.03960573196, 48536.5146348532, 38017.2396552073, 38219.61780382161, 38397.424038638885, 38475.807620961714, 38910.6108938907, 38582.80708596439, 38819.86490743036, 38825.805870970464, 39110.608893911834, 39558.80220598879, 37676.869693909226, 38509.807450962566, 38775.41836872393, 38938.6106138935, 39005.0, 32544.51183232206, 32867.34265314728, 33784.0, 33854.661453386136, 33922.8303858489, 25180.74819251784, 25301.114460993776, 25415.618765718158, 25849.224523264333, 25965.480690386463], "value": 19944.89352463305, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.84180932150446, 423.46008838730614, 424.04378127322883, 425.9318509038553, 435.21443793951903, 21045.473863153427, 21078.89460552697, 21791.346259612197, 23229.535409291802, 23237.535249295004, 21883.562328753414, 22010.119595216172, 22127.44681382966, 22132.336029919086, 22320.55358892825, 5839.620424672404, 6108.083787431877, 6150.138980542728, 6154.169187159743, 6164.630122192661, 4399.406080179167, 4498.797554110057, 4598.701084429501, 6056.545759068065, 6183.350748171445, 6721.63031033293, 6753.425958793484, 6762.087118239048, 6763.086983257246, 6787.524873258873, 5811.883762324772, 6129.785457508966, 6723.226828914689, 6740.595564266136, 6742.932570674279, 4109.91780164395, 4277.230098582254, 4289.378040184156, 4289.592488713567, 5984.401559844025, 12205.511779528808, 12474.376281185996, 13124.934375328063, 13326.533571324957, 23301.76698233013, 2151.7848215178515, 2166.8374871884516, 2216.0692509146197, 2280.486890449652, 2314.5718042162252, 10319.329243599143, 10560.683179504627, 11210.943945280304, 11290.830637540443, 15094.547163585, 1820.4265656318216, 1833.7432759413693, 1857.359211072178, 1873.2881505028001, 1909.0836398528784, 109439.0, 112905.87094129036, 118397.40801296025, 118760.40619796932, 120472.39763801213, 11760.823587646191, 11783.587574434854, 11928.701782455335, 11930.582429614922, 11959.880401195876, 15122.924385378003, 15139.0, 15160.241987900561, 15175.103112110986, 15212.771808422882, 9041.141091596288, 9172.8624070639, 9230.35387522867, 9322.95338523303, 9382.0, 9166.908330916738, 9190.218831399272, 9214.216791572657, 9219.677311294072, 9314.44113353201, 4765.8093676252565, 4779.450363208275, 4779.784909679072, 4792.329073929653, 4827.710337379698, 1735.557432854614, 1835.9449216523526, 1992.4620352504742, 2063.772984971652, 2087.77034526202, 939.2532936315646, 964.9179819715403, 976.2580438866371, 997.2371136080903, 1013.9138173255209, 16639.918405303615, 20390.69413958792, 20948.685769713466, 21171.259005934717, 21248.468788280417, 918.9816203675889, 923.9953800230955, 984.4142735072763, 998.3810037776625, 1050.2858056521638, 10914.672559823219, 11318.60384886525, 11332.0, 11343.489542970587, 11354.26197297173, 554740.0, 654900.0, 668824.0, 674469.0, 676634.0, 132487.3375633135, 132640.0, 136232.0, 140168.0, 140250.2987485056, 1048.895110488945, 1081.9945900270607, 1091.9727006824894, 1094.950727217277, 1099.3898386395467, 18528.81471185271, 18841.0, 19266.747661401965, 19267.132979015696, 19596.020198989707, 35278.82360588181, 53085.20372194343, 58488.0, 59284.40715592789, 60043.0, 78103.60948195223, 84010.57994710232, 87164.5641771787, 87616.56191719255, 87800.56099719461, 8125.8374832504205, 8186.836263274582, 8417.158284171534, 8533.658653653783, 8801.515916624647, 9333.113354231336, 12402.5659101931, 13027.544035958696, 13552.864471355555, 13557.322133893069, 11154.832677509681, 11501.367424791717, 11789.469473873525, 11808.350540720343, 11811.763764724828, 10750.08624266946, 10834.837477438003, 11305.0, 11524.769504609692, 11615.76768464643, 11694.649160525198, 11742.119341049285, 11930.940345298219, 12021.75956480883, 12211.816822747844, 8495.830083398174, 8607.741767746978, 8609.741707748777, 8630.611622476878, 8827.984781750181, 8720.43317184381, 11633.069354451793, 11665.941670291595, 11866.0, 11884.82172767392], "value": 9768.116495080787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.1824005916774, 1635.419426103733, 1655.6109314311138, 1815.4644379907925, 1966.6460037193299, 8328.417010809246, 9042.59308331125, 9182.908170918288, 9184.724458266246, 9199.034101419355, 8873.157050080248, 9129.68046118386, 9133.543322833848, 9146.99383067862, 9155.496447695374, 2553.0426090216215, 2583.8837252323597, 2584.547704151766, 2586.987065064672, 2589.572720501115, 2523.0, 2577.497388009339, 2589.443269697015, 2590.870456477178, 2593.688757349121, 2538.0, 2560.142352311978, 2583.870806459679, 2584.392667723093, 2588.676415448069, 2550.0564791027346, 2573.9485210295784, 2583.793296536282, 2587.8188526803133, 2588.4823035392997, 2528.4311030018284, 2562.0904578874606, 2572.1126211457017, 2577.935551611206, 2582.992632873181, 8911.841460610143, 9199.218066464358, 9200.907990920072, 9229.538523073887, 9242.86135707965, 5684.914726279109, 5831.912521312183, 5867.442592953706, 5915.763369465216, 5942.5840191186635, 3706.6664000240107, 3807.4098514730263, 3813.3707938190164, 3838.692904567628, 3869.090763670535, 913.8355096082703, 1068.1935138970105, 1084.1868598551087, 1086.6468397770757, 1119.5242022140558, 12356.505739770399, 12457.75084498314, 12555.874441255562, 12563.057770667145, 12626.053046021585, 4844.8304309349005, 4872.43966943806, 4892.584130348889, 4950.43070046942, 4991.700497970133, 9911.702648920544, 9913.752156196153, 9948.154406875352, 9958.352707074017, 9975.301728878909, 5696.857578560569, 5713.485786279171, 5717.2281741965135, 5729.083346664514, 5729.828105156852, 4573.108243892476, 4600.631949444037, 5080.644354895196, 5258.237555554423, 5265.341832270966, 4057.14799892026, 4085.59144085595, 4139.985703502661, 4161.895952601149, 4173.603507666767, 1268.8794564516356, 1275.1392809853312, 1275.929823859678, 1282.5062350994933, 1284.454107004538, 927.2674587076134, 938.7230766923774, 951.2817822543935, 969.8351280282369, 1011.2314640872843, 6065.6663883486835, 6122.7857025004805, 6192.969035154795, 6210.937890621036, 6220.409061139185, 418.2304559610271, 487.8707142607212, 490.4874406245411, 492.6108374384268, 499.51796516361156, 3464.6708562686504, 3922.37242041272, 4006.4991876015497, 4053.148838743838, 4129.938050929239, 11088.889111108785, 11589.536418543332, 11597.826032609517, 11615.36115513638, 11625.76748465026, 11295.03992160659, 11300.321980681021, 11314.264572802742, 11337.603183888525, 11399.772004559862, 8797.252233560219, 8899.777505562413, 8910.376273660782, 8910.420822646507, 8924.018357980747, 5847.327557330961, 5960.701964901824, 5982.162497250301, 6145.569810113428, 6237.282712488122, 10053.748656283651, 10127.088562029452, 10202.38785672862, 10227.539760710637, 10230.48847557634, 9881.50592470388, 10020.599176032876, 10033.698989030341, 10245.897541024793, 10257.948710256402, 7081.0, 7285.7814265572115, 7603.125640551408, 7788.961055194688, 7924.009498812648, 8655.48067115975, 8690.739277821676, 8702.347323950602, 8715.694950676696, 8727.869081963903, 7645.235476452533, 7712.614369281401, 7784.92215077842, 7868.763937081897, 7881.684732610632, 7569.432292577969, 7595.848083038198, 7668.1181664109345, 7769.378449723896, 7806.0632724073475, 7269.491135620668, 7415.073115860518, 7420.703171873281, 7421.628918554159, 7431.591262480615, 4892.535209155125, 4977.0, 5009.248612707977, 5095.464976177448, 5130.025295193901, 5169.689818610896, 5171.0394066474355, 5239.4236633970995, 5279.47205279469, 5287.709175995357], "value": 4723.334016382027, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.50456819339183, 335.7649645248325, 342.13781271196575, 345.4869518764636, 348.74890079143006, 6659.700313485892, 6666.4000239978395, 6690.2306234782955, 6694.598324100557, 6746.932530674691, 6648.368405001529, 6657.700403481843, 6675.265720770712, 6694.96652516738, 6785.457163426926, 4710.199266124759, 4883.047805677894, 4907.75461226939, 4917.06575750608, 4918.680285781431, 4869.9269510957365, 4930.926036109443, 4939.67892087015, 4971.676841005323, 4997.600191984632, 4896.657233993622, 4908.97545512272, 4939.506049395068, 4942.258661200831, 4953.207486802113, 4714.0, 4940.011997600476, 4952.455229924705, 4961.677490963076, 4986.0, 3428.674275943781, 4086.979565102185, 4225.619694227504, 4234.91530169398, 4248.192843359782, 5240.685558866442, 6270.372962703739, 6319.304876463585, 6366.490680745575, 6394.872102557969, 5879.882402351929, 5898.292204935436, 5900.0, 5911.467967882912, 5918.348981612019, 5769.711514424304, 7149.463790215755, 7155.6064416457075, 7157.4274058075225, 7197.748078817269, 3946.289667859784, 4443.622292105143, 4770.522947705202, 4793.209120495114, 4793.400824896888, 7385.409167266659, 7507.999999999945, 7568.810779730496, 7571.469997100206, 7574.3183113520045, 3910.569837317893, 4705.153072446924, 4714.504976977368, 4717.174494463524, 4723.173444647173, 4815.568138090242, 4816.54242846929, 4821.2045012572535, 4821.590164835958, 4827.686200397034, 5709.685967271756, 5712.742926568314, 5713.085906254979, 5717.571182161355, 5742.626729262584, 6807.353301436356, 7065.717371305193, 7172.605506697182, 7196.604186769673, 7197.784066478014, 1446.5081872163514, 1607.549886031913, 1634.8365163483556, 1644.0382376309992, 1662.7007138714905, 844.6494704697604, 1035.3206673166267, 1056.815057364958, 1057.931234469757, 1061.4162210784039, 5159.819406320761, 5881.0, 6225.782097626561, 6696.8995465068065, 6781.287964763727, 7307.817304567428, 7419.998300229508, 7460.626968651546, 7552.320291173821, 7555.584442855586, 6844.452443804584, 6865.347791959756, 6872.828179295558, 6880.931190688029, 6897.48268879826, 3910.452536644815, 3949.2299001694396, 3950.2889479893897, 3956.7032472564674, 3962.2867883781196, 7550.848983020309, 7859.960700196577, 7861.960690196627, 7866.724664636825, 7887.566183859943, 7657.655405506765, 7717.922820771832, 7719.11230208522, 7726.304632583095, 7757.146713861471, 7825.686972521035, 7834.451588388872, 7850.568218748023, 7855.4893931895385, 7879.763607091796, 7441.516301440389, 7451.701931922662, 7454.180040195466, 7465.365443937326, 7501.699932002659, 7042.084529011196, 7392.408607311295, 7414.0, 7421.962890185515, 7441.3674837637245, 6335.841603959938, 7875.251851074138, 7920.0, 7930.56381898978, 7936.920630793618, 3815.2369526094335, 4754.025424787841, 4764.309175169512, 4764.404449443819, 4769.66612337133, 7493.887591686238, 7504.0, 7517.473776835569, 7520.511166774142, 7529.924700752922, 6910.930890691029, 7149.356557909813, 7194.280571942764, 7262.419006479575, 7280.890786638311, 7187.928120718726, 7229.132504099542, 7243.0, 7249.637518124178, 7267.200607933018, 7085.539439936388, 7093.864981602918, 7094.787156385317, 7106.964465177641, 7136.571805691675, 6896.0, 7198.71205151788, 7218.422526197996, 7242.239564845615, 7252.166000909963, 6780.627065511247, 6919.7232110715, 6997.440204783707, 7031.929680703128, 7041.4014808739785], "value": 5218.948535435737, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.1674283630767, 798.5847359373126, 801.8877357169994, 805.53681633061, 807.1283014344508, 15478.690426191484, 15546.144962027083, 15813.288402021923, 15842.683146337067, 15856.127912964797, 14787.669109780118, 14855.7028859423, 14872.47946321879, 14886.776698349533, 14892.032017918827, 792.2948575767557, 813.5932033983008, 962.7448726087592, 976.8778902637171, 976.9706908792712, 975.0931633580767, 975.6536429567508, 979.9853002204973, 980.206033113177, 981.2444417798291, 822.198356602314, 1030.5723124903157, 1032.4166845732175, 1033.9534720937538, 1037.0873631204568, 1002.5087707023579, 1036.5491011410022, 1039.3348257115451, 1039.6309310194847, 1042.687193841852, 781.2851241114373, 781.6677911887482, 783.5768684910141, 784.7214238945149, 786.1470304719386, 15659.843401565953, 15706.293216805157, 15716.842831571767, 15749.921250393789, 15769.896107272496, 12995.415206315643, 13052.934735326358, 13265.27041012744, 13485.528006519724, 13500.0, 10198.949005255, 10366.06705396518, 10399.064084232456, 10695.946520267427, 10823.83764243537, 3558.09268636496, 3598.1904071583685, 3599.0102721751464, 3656.0859785053735, 3813.7902415367143, 78170.82743758848, 78240.0, 78510.0, 80280.59859700664, 80691.5965420175, 9755.365901216399, 9841.557129929028, 9853.261005424622, 9958.203343732484, 10080.899191007997, 21084.47288817761, 21290.893545532173, 21324.0, 21545.89227053886, 23082.884585576965, 7706.460547761715, 7715.035620547432, 7813.726519571787, 7817.726379576688, 8045.637946292431, 4284.143171365739, 4307.095509942885, 4318.3090705486975, 4391.055922976511, 4579.5878370946775, 3691.427828686504, 3760.9657344230554, 3768.4724138620613, 3768.717346199046, 3770.792606406619, 673.1148539670318, 681.1145510835894, 705.1679018757812, 724.398749038297, 726.8219286274897, 446.75875027485444, 520.7448350308398, 572.567711377907, 638.4158494977137, 644.136856612142, 8305.95847020761, 8495.27790137833, 8509.489430634181, 8655.437396569328, 8668.826623467496, 559.3651205881354, 611.8959776837949, 616.5191150902303, 629.5844742469948, 635.1742734445295, 4001.139754952699, 4014.0, 4047.352423612208, 4078.0620457294394, 4153.06556024892, 95450.0, 95666.52166739122, 96808.0, 96939.18364897987, 97800.51099744455, 84206.57896710477, 84483.5775821117, 85923.14076859152, 86364.0, 86461.0, 66337.66831165813, 73031.63484182545, 74166.88749668759, 74267.0, 74593.88109178367, 8555.828883422173, 8685.305175585812, 8693.869591956, 8804.427712198687, 8909.287257019552, 46470.767646161556, 47969.5203047979, 49990.75004624954, 50268.0, 50904.74547627238, 65766.0, 68709.86834579225, 70187.0, 70306.64846675734, 71221.28778712354, 10995.34027958325, 11201.103911687209, 11277.041451476716, 11452.312861228353, 11714.589989350332, 11875.228110172811, 12127.757444850877, 12147.878521214674, 12347.506099756269, 12557.748845022865, 11614.825777613512, 11741.002014828493, 11808.940955295513, 11828.526858925547, 12114.15200935926, 11455.198136130392, 11544.769104618028, 11720.179587429138, 12283.017358611469, 12471.688207794878, 11236.438178091226, 11389.772204556028, 11413.0, 11559.826602601135, 12306.630801075982, 9638.084381983701, 9770.36492627977, 10050.899491004997, 10055.798884022131, 10370.533326000197, 9644.228461722905, 10003.249756268455, 10053.447060411747, 10115.14021308197, 10254.53854576531], "value": 7212.542681068828, "unit": "score"}], "name": "dromaeo_css", "value": 7680.517762568218, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 121.0, 111.0, 112.0, 111.0, 115.0, 113.0, 114.0, 135.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 143.0, 163.0, 115.0, 137.0, 117.0, 151.0, 153.0, 115.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 185.0, 185.0, 182.0, 182.0, 183.0, 186.0, 185.0, 183.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 79.0, 72.0, 150.0, 56.0, 56.0, 56.0, 67.0, 132.0, 55.0], "value": 79.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 138.0, 79.0, 90.0, 87.0, 126.0, 80.0, 76.0, 126.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 88.0, 86.0, 89.0, 127.0, 89.0, 86.0, 106.0, 108.0], "value": 103.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 92.0, 92.0, 93.0, 93.0, 93.0, 92.0, 92.0, 92.0], "value": 92.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 99.0, 135.0, 142.0, 85.0, 82.0, 85.0, 83.0, 85.0, 84.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 64.0, 62.0, 62.0, 61.0, 62.0, 77.0, 58.0, 56.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 72.0, 74.0, 69.0, 66.0, 65.0, 68.0, 67.0, 66.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 76.0, 80.0, 77.0, 78.0, 79.0, 78.0, 78.0, 83.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 124.0, 124.0, 126.0, 139.0, 120.0, 120.0, 122.0, 142.0, 130.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 159.0, 171.0, 163.0, 163.0, 162.0, 157.0, 164.0, 159.0, 164.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 65.0, 66.0, 68.0, 67.0, 72.0, 98.0, 102.0, 98.0], "value": 76.9, "unit": "score"}], "name": "kraken", "value": 1482.8, "alertThreshold": 2.0}]} 12:11:53 INFO - Return code: 0 12:11:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:11:53 ERROR - # TBPL SUCCESS # 12:11:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:11:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:11:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:11:53 INFO - 2016-07-15 12:11:53.796 screenresolution[1680:9761] starting screenresolution argv=screenresolution get 12:11:53 INFO - 2016-07-15 12:11:53.799 screenresolution[1680:9761] Display 0: 1600x1200x32@60 12:11:53 INFO - 2016-07-15 12:11:53.805 screenresolution[1681:9764] starting screenresolution argv=screenresolution list 12:11:53 INFO - Available Modes on Display 0 12:11:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:11:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:11:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:11:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:11:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:11:54 INFO - Intel Iris: 12:11:54 INFO - Chipset Model: Intel Iris 12:11:54 INFO - Type: GPU 12:11:54 INFO - Bus: Built-In 12:11:54 INFO - VRAM (Dynamic, Max): 1536 MB 12:11:54 INFO - Vendor: Intel (0x8086) 12:11:54 INFO - Device ID: 0x0a2e 12:11:54 INFO - Revision ID: 0x0009 12:11:54 INFO - Displays: 12:11:54 INFO - Display: 12:11:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:11:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:11:54 INFO - Display Serial Number: 1600x1200 60 12:11:54 INFO - Main Display: Yes 12:11:54 INFO - Mirror: Off 12:11:54 INFO - Online: Yes 12:11:54 INFO - Rotation: Supported 12:11:54 INFO - Return code: 0 12:11:54 INFO - Running post-action listener: _resource_record_post_action 12:11:54 INFO - Running post-run listener: _resource_record_post_run 12:11:55 INFO - Total resource usage - Wall time: 1194s; CPU: 52.0%; Read bytes: 38094336; Write bytes: 491812864; Read time: 402; Write time: 1510 12:11:55 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 185025024; Write bytes: 175390720; Read time: 16567; Write time: 313 12:11:55 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 37172736; Write bytes: 297084928; Read time: 382; Write time: 1094 12:11:55 INFO - Running post-run listener: _upload_blobber_files 12:11:55 INFO - Blob upload gear active. 12:11:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:11:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:11:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:11:55 INFO - (blobuploader) - INFO - Open directory for files ... 12:11:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:11:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:11:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:56 INFO - (blobuploader) - INFO - Done attempting. 12:11:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:11:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:11:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:57 INFO - (blobuploader) - INFO - Done attempting. 12:11:57 INFO - (blobuploader) - INFO - Iteration through files over. 12:11:57 INFO - Return code: 0 12:11:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:11:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:11:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e37fac0ae79f21352ba26df37bd7765cc360dce677182bb2e976e9f7a3cee2f30c525b58453348e9fe08b1ea544e24e8af50d42ac6a897813f2418430093c89d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/909b621e0f45a8521a43efbd59a30e4048cefa5e62d9f38066df492e47ffa236915e87045373e32d2012740ee45497a18dfaaf571468c14b10c29237665d5360"} 12:11:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:11:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:11:57 INFO - Contents: 12:11:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e37fac0ae79f21352ba26df37bd7765cc360dce677182bb2e976e9f7a3cee2f30c525b58453348e9fe08b1ea544e24e8af50d42ac6a897813f2418430093c89d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/909b621e0f45a8521a43efbd59a30e4048cefa5e62d9f38066df492e47ffa236915e87045373e32d2012740ee45497a18dfaaf571468c14b10c29237665d5360"} 12:11:57 INFO - Running post-run listener: copy_logs_to_upload_dir 12:11:57 INFO - Copying logs to upload dir... 12:11:57 INFO - mkdir: /builds/slave/test/build/upload/logs 12:11:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.005227 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-15 12:11:57.192857) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 12:11:57.196704) ========= 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.O74jjRcrll/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.DZceUXPfH4/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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/e37fac0ae79f21352ba26df37bd7765cc360dce677182bb2e976e9f7a3cee2f30c525b58453348e9fe08b1ea544e24e8af50d42ac6a897813f2418430093c89d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/909b621e0f45a8521a43efbd59a30e4048cefa5e62d9f38066df492e47ffa236915e87045373e32d2012740ee45497a18dfaaf571468c14b10c29237665d5360"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011085 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468333317/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e37fac0ae79f21352ba26df37bd7765cc360dce677182bb2e976e9f7a3cee2f30c525b58453348e9fe08b1ea544e24e8af50d42ac6a897813f2418430093c89d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/909b621e0f45a8521a43efbd59a30e4048cefa5e62d9f38066df492e47ffa236915e87045373e32d2012740ee45497a18dfaaf571468c14b10c29237665d5360"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 12:11:57.229790) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:11:57.230100) ========= 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.O74jjRcrll/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.DZceUXPfH4/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.005019 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:11:57.278586) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 12:11:57.278884) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 12:11:57.279198) ========= ========= Total master_lag: 0.17 =========