builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0188 starttime: 1465288632.97 results: success (0) buildid: 20160606120332 builduid: 394ff36afaaf47b0a5ccdc9e3ac607e3 revision: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:12.971650) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:12.972099) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:12.972372) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:12.994916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:12.995228) ========= 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.YqMqFTMSco/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.58ZqAw1Jdk/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-07 01:37:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 145M=0s 2016-06-07 01:37:13 (145 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.402554 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:13.418401) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:13.418724) ========= 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.YqMqFTMSco/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.58ZqAw1Jdk/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.020315 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:13.467433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-07 01:37:13.467793) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 --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 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YqMqFTMSco/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.58ZqAw1Jdk/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-07 01:37:13,541 truncating revision to first 12 chars 2016-06-07 01:37:13,541 Setting DEBUG logging. 2016-06-07 01:37:13,541 attempt 1/10 2016-06-07 01:37:13,541 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/46d72a56c57d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 01:37:15,355 unpacking tar archive at: mozilla-beta-46d72a56c57d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.097497 ========= master_lag: 0.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-07 01:37:15.821507) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:15.821848) ========= script_repo_revision: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:15.822287) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:15.822568) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:15.840710) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-07 01:37:15.841141) ========= /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.YqMqFTMSco/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.58ZqAw1Jdk/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 01:37:16 INFO - MultiFileLogger online at 20160607 01:37:16 in /builds/slave/test 01:37:16 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 01:37:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:37:16 INFO - {'append_to_log': False, 01:37:16 INFO - 'base_work_dir': '/builds/slave/test', 01:37:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:37:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:37:16 INFO - 'branch': 'Mozilla-Beta', 01:37:16 INFO - 'buildbot_json_path': 'buildprops.json', 01:37:16 INFO - 'config_files': ('talos/mac_config.py',), 01:37:16 INFO - 'default_actions': ('clobber', 01:37:16 INFO - 'read-buildbot-config', 01:37:16 INFO - 'download-and-extract', 01:37:16 INFO - 'populate-webroot', 01:37:16 INFO - 'create-virtualenv', 01:37:16 INFO - 'install', 01:37:16 INFO - 'run-tests'), 01:37:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:37:16 INFO - 'download_minidump_stackwalk': True, 01:37:16 INFO - 'download_symbols': 'ondemand', 01:37:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:37:16 INFO - 'tooltool.py': '/tools/tooltool.py', 01:37:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:37:16 INFO - '/tools/misc-python/virtualenv.py')}, 01:37:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:37:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:37:16 INFO - 'installer_path': 'installer.exe', 01:37:16 INFO - 'log_level': 'info', 01:37:16 INFO - 'log_name': 'talos', 01:37:16 INFO - 'log_to_console': True, 01:37:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:37:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:37:16 INFO - 'opt_config_files': (), 01:37:16 INFO - 'pip_index': False, 01:37:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:37:16 INFO - 'cmd': ('bash', 01:37:16 INFO - '-c', 01:37:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:37:16 INFO - 'enabled': True, 01:37:16 INFO - 'halt_on_failure': False, 01:37:16 INFO - 'name': 'check_screen_resolution'},), 01:37:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:37:16 INFO - 'cmd': ('bash', 01:37:16 INFO - '-c', 01:37:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:37:16 INFO - 'enabled': True, 01:37:16 INFO - 'halt_on_failure': False, 01:37:16 INFO - 'name': 'check_screen_resolution'},), 01:37:16 INFO - 'run_cmd_checks_enabled': True, 01:37:16 INFO - 'sps_profile': False, 01:37:16 INFO - 'sps_profile_interval': 0, 01:37:16 INFO - 'suite': 'dromaeojs', 01:37:16 INFO - 'system_bits': '32', 01:37:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:37:16 INFO - 'title': 't-yosemite-r7-0188', 01:37:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:37:16 INFO - 'use_talos_json': True, 01:37:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:37:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:37:16 INFO - 'work_dir': 'build'} 01:37:16 INFO - ##### 01:37:16 INFO - ##### Running clobber step. 01:37:16 INFO - ##### 01:37:16 INFO - Running pre-action listener: _resource_record_pre_action 01:37:16 INFO - Running main action method: clobber 01:37:16 INFO - rmtree: /builds/slave/test/build 01:37:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:37:17 INFO - Running post-action listener: _resource_record_post_action 01:37:17 INFO - ##### 01:37:17 INFO - ##### Running read-buildbot-config step. 01:37:17 INFO - ##### 01:37:17 INFO - Running pre-action listener: _resource_record_pre_action 01:37:17 INFO - Running main action method: read_buildbot_config 01:37:17 INFO - Using buildbot properties: 01:37:17 INFO - { 01:37:17 INFO - "project": "", 01:37:17 INFO - "product": "firefox", 01:37:17 INFO - "script_repo_revision": "production", 01:37:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 01:37:17 INFO - "repository": "", 01:37:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 01:37:17 INFO - "buildid": "20160606120332", 01:37:17 INFO - "pgo_build": "False", 01:37:17 INFO - "basedir": "/builds/slave/test", 01:37:17 INFO - "buildnumber": 1, 01:37:17 INFO - "slavename": "t-yosemite-r7-0188", 01:37:17 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 01:37:17 INFO - "platform": "yosemite_r7", 01:37:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 01:37:17 INFO - "branch": "mozilla-beta", 01:37:17 INFO - "repo_path": "releases/mozilla-beta", 01:37:17 INFO - "revision": "46d72a56c57dafb4dc1061d4741a3e1181ac3d68", 01:37:17 INFO - "stage_platform": "macosx64", 01:37:17 INFO - "builduid": "394ff36afaaf47b0a5ccdc9e3ac607e3", 01:37:17 INFO - "slavebuilddir": "test" 01:37:17 INFO - } 01:37:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 01:37:17 INFO - Running post-action listener: _resource_record_post_action 01:37:17 INFO - ##### 01:37:17 INFO - ##### Running download-and-extract step. 01:37:17 INFO - ##### 01:37:17 INFO - Running pre-action listener: _resource_record_pre_action 01:37:17 INFO - Running main action method: download_and_extract 01:37:17 INFO - mkdir: /builds/slave/test/build/tests 01:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:17 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:37:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:37:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:37:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:37:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 01:37:19 INFO - Downloaded 1165 bytes. 01:37:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:37:19 INFO - Using the following test package requirements: 01:37:19 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:37:19 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:19 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 01:37:19 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:19 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 01:37:19 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 01:37:19 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:19 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 01:37:19 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:37:19 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:19 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 01:37:19 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:19 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 01:37:19 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:19 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 01:37:19 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:19 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 01:37:19 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 01:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:19 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:37:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:37:20 INFO - Downloaded 18292404 bytes. 01:37:20 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'] 01:37:20 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 01:37:24 INFO - Return code: 0 01:37:24 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 01:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:24 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:37:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:37:26 INFO - Downloaded 18292404 bytes. 01:37:26 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'] 01:37:26 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 01:37:29 INFO - Return code: 0 01:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:29 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:37:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:37:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:37:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 01:37:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 01:37:30 INFO - Downloaded 10840145 bytes. 01:37:30 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'] 01:37:30 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 01:37:30 INFO - Return code: 0 01:37:30 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')]} 01:37:30 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 01:37:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 01:37:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 01:37:33 INFO - Downloaded 86246253 bytes. 01:37:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:33 INFO - mkdir: /builds/slave/test/properties 01:37:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:37:33 INFO - Writing to file /builds/slave/test/properties/build_url 01:37:33 INFO - Contents: 01:37:33 INFO - build_url:https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:34 INFO - Running post-action listener: _resource_record_post_action 01:37:34 INFO - Running post-action listener: set_extra_try_arguments 01:37:34 INFO - ##### 01:37:34 INFO - ##### Running populate-webroot step. 01:37:34 INFO - ##### 01:37:34 INFO - Running pre-action listener: _resource_record_pre_action 01:37:34 INFO - Running main action method: populate_webroot 01:37:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:37:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:37:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:37:34 INFO - '--tppagecycles', 01:37:34 INFO - '7'], 01:37:34 INFO - 'tests': ['tsvgm']}}, 01:37:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:37:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:37:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:37:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:37:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:37:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:37:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:34 INFO - 'talos_options': ['--disable-e10s'], 01:37:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:34 INFO - 'talos_options': ['--disable-e10s'], 01:37:34 INFO - 'tests': ['damp', 'tps']}, 01:37:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:34 INFO - 'tests': ['damp', 'tps']}, 01:37:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:37:34 INFO - 'tests': ['dromaeo_dom']}, 01:37:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:37:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:37:34 INFO - 'tests': ['a11yr', 01:37:34 INFO - 'ts_paint', 01:37:34 INFO - 'tpaint', 01:37:34 INFO - 'sessionrestore', 01:37:34 INFO - 'sessionrestore_no_auto_restore', 01:37:34 INFO - 'tabpaint']}, 01:37:34 INFO - 'other-e10s': {'tests': ['a11yr', 01:37:34 INFO - 'ts_paint', 01:37:34 INFO - 'tpaint', 01:37:34 INFO - 'sessionrestore', 01:37:34 INFO - 'sessionrestore_no_auto_restore', 01:37:34 INFO - 'tabpaint']}, 01:37:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:37:34 INFO - 'ts_paint', 01:37:34 INFO - 'tpaint', 01:37:34 INFO - 'sessionrestore', 01:37:34 INFO - 'sessionrestore_no_auto_restore', 01:37:34 INFO - 'tabpaint']}, 01:37:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:37:34 INFO - 'ts_paint', 01:37:34 INFO - 'tpaint', 01:37:34 INFO - 'sessionrestore', 01:37:34 INFO - 'sessionrestore_no_auto_restore', 01:37:34 INFO - 'tabpaint']}, 01:37:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:37:34 INFO - 'tests': ['a11yr', 01:37:34 INFO - 'ts_paint', 01:37:34 INFO - 'tpaint', 01:37:34 INFO - 'sessionrestore', 01:37:34 INFO - 'sessionrestore_no_auto_restore', 01:37:34 INFO - 'tabpaint']}, 01:37:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:37:34 INFO - 'tests': ['a11yr', 01:37:34 INFO - 'ts_paint', 01:37:34 INFO - 'tpaint', 01:37:34 INFO - 'sessionrestore', 01:37:34 INFO - 'sessionrestore_no_auto_restore', 01:37:34 INFO - 'tabpaint']}, 01:37:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:37:34 INFO - 'tests': ['tsvgx', 01:37:34 INFO - 'tsvgr_opacity', 01:37:34 INFO - 'tart', 01:37:34 INFO - 'tscrollx', 01:37:34 INFO - 'cart']}, 01:37:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:37:34 INFO - 'tsvgr_opacity', 01:37:34 INFO - 'tart', 01:37:34 INFO - 'tscrollx', 01:37:34 INFO - 'cart']}, 01:37:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:34 INFO - 'talos_options': ['--disable-e10s'], 01:37:34 INFO - 'tests': ['tp5o']}, 01:37:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:34 INFO - 'tests': ['tp5o']}, 01:37:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:34 INFO - 'talos_options': ['--disable-e10s', 01:37:34 INFO - '--xperf_path', 01:37:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:34 INFO - 'tests': ['tp5n']}, 01:37:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:34 INFO - 'talos_options': ['--xperf_path', 01:37:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:34 INFO - 'tests': ['tp5n']}}, 01:37:34 INFO - 'talos.zip': {'path': '', 01:37:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:37:34 INFO - Running post-action listener: _resource_record_post_action 01:37:34 INFO - ##### 01:37:34 INFO - ##### Running create-virtualenv step. 01:37:34 INFO - ##### 01:37:34 INFO - Running pre-action listener: _resource_record_pre_action 01:37:34 INFO - Running main action method: create_virtualenv 01:37:34 INFO - Creating virtualenv /builds/slave/test/build/venv 01:37:34 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 01:37:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:37:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:37:34 INFO - Using real prefix '/tools/python27' 01:37:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:37:35 INFO - Installing distribute.............................................................................................................................................................................................done. 01:37:38 INFO - Installing pip.................done. 01:37:38 INFO - Return code: 0 01:37:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:37:38 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')]} 01:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:38 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')]} 01:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:38 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 0x104ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ac3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f52566c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104952e00>, '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 0x1047bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10494db20>, '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.YqMqFTMSco/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.58ZqAw1Jdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 01:37:38 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 01:37:38 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 01:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqMqFTMSco/Render', 01:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:38 INFO - 'HOME': '/Users/cltbld', 01:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:38 INFO - 'LOGNAME': 'cltbld', 01:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:38 INFO - 'MOZ_NO_REMOTE': '1', 01:37:38 INFO - 'NO_EM_RESTART': '1', 01:37:38 INFO - 'PAGER': '/bin/cat', 01:37:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:38 INFO - 'PWD': '/builds/slave/test', 01:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:38 INFO - 'SHELL': '/bin/bash', 01:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.58ZqAw1Jdk/Listeners', 01:37:38 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 01:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:38 INFO - 'USER': 'cltbld', 01:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:38 INFO - 'XPC_FLAGS': '0x0', 01:37:38 INFO - 'XPC_SERVICE_NAME': '0', 01:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:38 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 01:37:38 INFO - Cleaning up... 01:37:38 INFO - Return code: 0 01:37:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:37:38 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')]} 01:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:38 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')]} 01:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:38 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 0x104ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ac3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f52566c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104952e00>, '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 0x1047bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10494db20>, '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.YqMqFTMSco/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.58ZqAw1Jdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 01:37:38 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 01:37:38 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 01:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqMqFTMSco/Render', 01:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:38 INFO - 'HOME': '/Users/cltbld', 01:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:38 INFO - 'LOGNAME': 'cltbld', 01:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:38 INFO - 'MOZ_NO_REMOTE': '1', 01:37:38 INFO - 'NO_EM_RESTART': '1', 01:37:38 INFO - 'PAGER': '/bin/cat', 01:37:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:38 INFO - 'PWD': '/builds/slave/test', 01:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:38 INFO - 'SHELL': '/bin/bash', 01:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.58ZqAw1Jdk/Listeners', 01:37:38 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 01:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:38 INFO - 'USER': 'cltbld', 01:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:38 INFO - 'XPC_FLAGS': '0x0', 01:37:38 INFO - 'XPC_SERVICE_NAME': '0', 01:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:38 INFO - Downloading/unpacking psutil>=0.7.1 01:37:38 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 01:37:38 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 01:37:38 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 01:37:38 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 01:37:38 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 01:37:38 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 01:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:37:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:41 INFO - Installing collected packages: psutil 01:37:41 INFO - Running setup.py install for psutil 01:37:41 INFO - building 'psutil._psutil_osx' extension 01:37:41 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 01:37:41 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 01:37:41 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 01:37:42 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 01:37:42 INFO - building 'psutil._psutil_posix' extension 01:37:42 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 01:37:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:37:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:37:42 INFO - ^ 01:37:42 INFO - 1 warning generated. 01:37:42 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 01:37:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:42 INFO - Successfully installed psutil 01:37:42 INFO - Cleaning up... 01:37:42 INFO - Return code: 0 01:37:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:42 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 0x104ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ac3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f52566c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104952e00>, '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 0x1047bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10494db20>, '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.YqMqFTMSco/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.58ZqAw1Jdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 01:37:42 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 01:37:42 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 01:37:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqMqFTMSco/Render', 01:37:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:42 INFO - 'HOME': '/Users/cltbld', 01:37:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:42 INFO - 'LOGNAME': 'cltbld', 01:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:42 INFO - 'MOZ_NO_REMOTE': '1', 01:37:42 INFO - 'NO_EM_RESTART': '1', 01:37:42 INFO - 'PAGER': '/bin/cat', 01:37:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:42 INFO - 'PWD': '/builds/slave/test', 01:37:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:42 INFO - 'SHELL': '/bin/bash', 01:37:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.58ZqAw1Jdk/Listeners', 01:37:42 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 01:37:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:42 INFO - 'USER': 'cltbld', 01:37:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:42 INFO - 'XPC_FLAGS': '0x0', 01:37:42 INFO - 'XPC_SERVICE_NAME': '0', 01:37:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:37:42 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 01:37:42 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 01:37:42 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 01:37:42 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 01:37:42 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 01:37:42 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 01:37:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:37:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:37:45 INFO - Installing collected packages: mozsystemmonitor 01:37:45 INFO - Running setup.py install for mozsystemmonitor 01:37:45 INFO - Successfully installed mozsystemmonitor 01:37:45 INFO - Cleaning up... 01:37:45 INFO - Return code: 0 01:37:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:45 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 0x104ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ac3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f52566c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104952e00>, '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 0x1047bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10494db20>, '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.YqMqFTMSco/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.58ZqAw1Jdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 01:37:45 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 01:37:45 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 01:37:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqMqFTMSco/Render', 01:37:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:45 INFO - 'HOME': '/Users/cltbld', 01:37:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:45 INFO - 'LOGNAME': 'cltbld', 01:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:45 INFO - 'MOZ_NO_REMOTE': '1', 01:37:45 INFO - 'NO_EM_RESTART': '1', 01:37:45 INFO - 'PAGER': '/bin/cat', 01:37:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:45 INFO - 'PWD': '/builds/slave/test', 01:37:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:45 INFO - 'SHELL': '/bin/bash', 01:37:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.58ZqAw1Jdk/Listeners', 01:37:45 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 01:37:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:45 INFO - 'USER': 'cltbld', 01:37:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:45 INFO - 'XPC_FLAGS': '0x0', 01:37:45 INFO - 'XPC_SERVICE_NAME': '0', 01:37:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:45 INFO - Downloading/unpacking blobuploader==1.2.4 01:37:45 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 01:37:45 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 01:37:45 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 01:37:45 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 01:37:45 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 01:37:45 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 01:37:48 INFO - Downloading blobuploader-1.2.4.tar.gz 01:37:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:37:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:37:48 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 01:37:48 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 01:37:48 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 01:37:48 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 01:37:48 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 01:37:48 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 01:37:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:37:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:49 INFO - Downloading docopt-0.6.1.tar.gz 01:37:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:37:49 INFO - Installing collected packages: blobuploader, requests, docopt 01:37:49 INFO - Running setup.py install for blobuploader 01:37:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:37:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:37:49 INFO - Running setup.py install for requests 01:37:50 INFO - Running setup.py install for docopt 01:37:50 INFO - Successfully installed blobuploader requests docopt 01:37:50 INFO - Cleaning up... 01:37:50 INFO - Return code: 0 01:37:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:50 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 0x104ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ac3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f52566c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104952e00>, '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 0x1047bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10494db20>, '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.YqMqFTMSco/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.58ZqAw1Jdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 01:37:50 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 01:37:50 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 01:37:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqMqFTMSco/Render', 01:37:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:50 INFO - 'HOME': '/Users/cltbld', 01:37:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:50 INFO - 'LOGNAME': 'cltbld', 01:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:50 INFO - 'MOZ_NO_REMOTE': '1', 01:37:50 INFO - 'NO_EM_RESTART': '1', 01:37:50 INFO - 'PAGER': '/bin/cat', 01:37:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:50 INFO - 'PWD': '/builds/slave/test', 01:37:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:50 INFO - 'SHELL': '/bin/bash', 01:37:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.58ZqAw1Jdk/Listeners', 01:37:50 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 01:37:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:50 INFO - 'USER': 'cltbld', 01:37:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:50 INFO - 'XPC_FLAGS': '0x0', 01:37:50 INFO - 'XPC_SERVICE_NAME': '0', 01:37:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:37:50 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-jwWNow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:37:50 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-dK_dtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:37:51 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-gVmAPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:37:51 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-rNegsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:37:51 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-iTzmmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:37:51 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-HaGoAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:37:51 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-4OzJSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:37:51 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-pqIJl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:37:51 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-zffLCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:37:51 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-X91dGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:37:51 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-TD9jlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:37:51 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-tiSHob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:37:52 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-ebI865-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:37:52 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-2UU5ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:52 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-6xWA9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:37:52 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-NocPIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:37:52 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-xaT9sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:37:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:37:52 INFO - Running setup.py install for manifestparser 01:37:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:37:52 INFO - Running setup.py install for mozcrash 01:37:52 INFO - Running setup.py install for mozdebug 01:37:53 INFO - Running setup.py install for mozdevice 01:37:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Running setup.py install for mozfile 01:37:53 INFO - Running setup.py install for mozhttpd 01:37:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Running setup.py install for mozinfo 01:37:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Running setup.py install for mozInstall 01:37:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Running setup.py install for mozleak 01:37:53 INFO - Running setup.py install for mozlog 01:37:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:37:54 INFO - Running setup.py install for moznetwork 01:37:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:37:54 INFO - Running setup.py install for mozprocess 01:37:54 INFO - Running setup.py install for mozprofile 01:37:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:37:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:37:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:37:54 INFO - Running setup.py install for mozrunner 01:37:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:37:54 INFO - Running setup.py install for mozscreenshot 01:37:54 INFO - Running setup.py install for moztest 01:37:55 INFO - Running setup.py install for mozversion 01:37:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:37:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:37:55 INFO - Cleaning up... 01:37:55 INFO - Return code: 0 01:37:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:55 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 0x104ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ac3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f52566c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104952e00>, '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 0x1047bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10494db20>, '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.YqMqFTMSco/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.58ZqAw1Jdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 01:37:55 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 01:37:55 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 01:37:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqMqFTMSco/Render', 01:37:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:55 INFO - 'HOME': '/Users/cltbld', 01:37:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:55 INFO - 'LOGNAME': 'cltbld', 01:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:55 INFO - 'MOZ_NO_REMOTE': '1', 01:37:55 INFO - 'NO_EM_RESTART': '1', 01:37:55 INFO - 'PAGER': '/bin/cat', 01:37:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:55 INFO - 'PWD': '/builds/slave/test', 01:37:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:55 INFO - 'SHELL': '/bin/bash', 01:37:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.58ZqAw1Jdk/Listeners', 01:37:55 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 01:37:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:55 INFO - 'USER': 'cltbld', 01:37:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:55 INFO - 'XPC_FLAGS': '0x0', 01:37:55 INFO - 'XPC_SERVICE_NAME': '0', 01:37:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:37:55 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-gzKY_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:37:55 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-GHGxfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:37:55 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-t9W9zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:37:55 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-mnYs5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:37:55 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-hgFBqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:37:55 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-PRJmfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:37:56 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)) 01:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:37:56 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-Y_IzSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:37:56 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)) 01:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:37:56 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-4NVhVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:37:56 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)) 01:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:37:56 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-onuhPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:37:56 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)) 01:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:37:56 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-gU82V4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:37:56 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)) 01:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:37:56 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-aSMZzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:37:56 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)) 01:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:37:56 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-H97C09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:37:56 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)) 01:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:37:56 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-y0fA5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:37:56 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)) 01:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:37:56 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-0zekEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:37:56 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)) 01:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:56 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-J2k7vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:57 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)) 01:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:37:57 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-KlHMd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:37:57 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)) 01:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:37:57 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-Yh5PQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:37:57 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)) 01:37:57 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)) 01:37:57 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)) 01:37:57 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)) 01:37:57 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)) 01:37:57 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)) 01:37:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37:59 INFO - Downloading blessings-1.6.tar.gz 01:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:37:59 INFO - Installing collected packages: blessings 01:37:59 INFO - Running setup.py install for blessings 01:37:59 INFO - Successfully installed blessings 01:37:59 INFO - Cleaning up... 01:38:00 INFO - Return code: 0 01:38:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:38:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:38:00 INFO - Reading from file tmpfile_stdout 01:38:00 INFO - Current package versions: 01:38:00 INFO - blessings == 1.6 01:38:00 INFO - blobuploader == 1.2.4 01:38:00 INFO - docopt == 0.6.1 01:38:00 INFO - manifestparser == 1.1 01:38:00 INFO - mozInstall == 1.12 01:38:00 INFO - mozcrash == 0.17 01:38:00 INFO - mozdebug == 0.1 01:38:00 INFO - mozdevice == 0.48 01:38:00 INFO - mozfile == 1.2 01:38:00 INFO - mozhttpd == 0.7 01:38:00 INFO - mozinfo == 0.9 01:38:00 INFO - mozleak == 0.1 01:38:00 INFO - mozlog == 3.1 01:38:00 INFO - moznetwork == 0.27 01:38:00 INFO - mozprocess == 0.22 01:38:00 INFO - mozprofile == 0.28 01:38:00 INFO - mozrunner == 6.11 01:38:00 INFO - mozscreenshot == 0.1 01:38:00 INFO - mozsystemmonitor == 0.0 01:38:00 INFO - moztest == 0.7 01:38:00 INFO - mozversion == 1.4 01:38:00 INFO - psutil == 3.1.1 01:38:00 INFO - requests == 1.2.3 01:38:00 INFO - wsgiref == 0.1.2 01:38:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38:00 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')]} 01:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:00 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')]} 01:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:00 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 0x104ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ac3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f52566c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104952e00>, '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 0x1047bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10494db20>, '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.YqMqFTMSco/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.58ZqAw1Jdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 01:38:00 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 01:38:00 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 01:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqMqFTMSco/Render', 01:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:00 INFO - 'HOME': '/Users/cltbld', 01:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:00 INFO - 'LOGNAME': 'cltbld', 01:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:00 INFO - 'MOZ_NO_REMOTE': '1', 01:38:00 INFO - 'NO_EM_RESTART': '1', 01:38:00 INFO - 'PAGER': '/bin/cat', 01:38:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:00 INFO - 'PWD': '/builds/slave/test', 01:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:00 INFO - 'SHELL': '/bin/bash', 01:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.58ZqAw1Jdk/Listeners', 01:38:00 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 01:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:00 INFO - 'USER': 'cltbld', 01:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:00 INFO - 'XPC_FLAGS': '0x0', 01:38:00 INFO - 'XPC_SERVICE_NAME': '0', 01:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:00 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)) 01:38:00 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)) 01:38:00 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)) 01:38:00 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)) 01:38:00 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)) 01:38:00 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)) 01:38:00 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)) 01:38:00 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)) 01:38:00 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)) 01:38:00 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)) 01:38:00 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)) 01:38:00 INFO - Cleaning up... 01:38:00 INFO - Return code: 0 01:38:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:38:00 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')]} 01:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:00 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')]} 01:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:00 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 0x104ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ac3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f52566c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104952e00>, '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 0x1047bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10494db20>, '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.YqMqFTMSco/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.58ZqAw1Jdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 01:38:00 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 01:38:00 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 01:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqMqFTMSco/Render', 01:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:00 INFO - 'HOME': '/Users/cltbld', 01:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:00 INFO - 'LOGNAME': 'cltbld', 01:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:00 INFO - 'MOZ_NO_REMOTE': '1', 01:38:00 INFO - 'NO_EM_RESTART': '1', 01:38:00 INFO - 'PAGER': '/bin/cat', 01:38:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:00 INFO - 'PWD': '/builds/slave/test', 01:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:00 INFO - 'SHELL': '/bin/bash', 01:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.58ZqAw1Jdk/Listeners', 01:38:00 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 01:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:00 INFO - 'USER': 'cltbld', 01:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:00 INFO - 'XPC_FLAGS': '0x0', 01:38:00 INFO - 'XPC_SERVICE_NAME': '0', 01:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:00 INFO - Downloading/unpacking jsonschema 01:38:00 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 01:38:00 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 01:38:00 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 01:38:00 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 01:38:00 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 01:38:00 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 01:38:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:38:03 INFO - Downloading/unpacking functools32 (from jsonschema) 01:38:03 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 01:38:03 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 01:38:03 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 01:38:03 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 01:38:03 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 01:38:03 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 01:38:03 INFO - Downloading functools32-3.2.3-2.tar.gz 01:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:38:03 INFO - warning: no files found matching '*.txt' 01:38:03 INFO - no previously-included directories found matching 'build' 01:38:03 INFO - no previously-included directories found matching 'dist' 01:38:03 INFO - no previously-included directories found matching '.git*' 01:38:03 INFO - Installing collected packages: jsonschema, functools32 01:38:03 INFO - Running setup.py install for functools32 01:38:03 INFO - warning: no files found matching '*.txt' 01:38:03 INFO - no previously-included directories found matching 'build' 01:38:03 INFO - no previously-included directories found matching 'dist' 01:38:03 INFO - no previously-included directories found matching '.git*' 01:38:03 INFO - Successfully installed jsonschema functools32 01:38:03 INFO - Cleaning up... 01:38:03 INFO - Return code: 0 01:38:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:38:03 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')]} 01:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:03 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')]} 01:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:03 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 0x104ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ac3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f52566c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104952e00>, '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 0x1047bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10494db20>, '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.YqMqFTMSco/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.58ZqAw1Jdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 01:38:03 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 01:38:03 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 01:38:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqMqFTMSco/Render', 01:38:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:03 INFO - 'HOME': '/Users/cltbld', 01:38:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:03 INFO - 'LOGNAME': 'cltbld', 01:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:03 INFO - 'MOZ_NO_REMOTE': '1', 01:38:03 INFO - 'NO_EM_RESTART': '1', 01:38:03 INFO - 'PAGER': '/bin/cat', 01:38:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:03 INFO - 'PWD': '/builds/slave/test', 01:38:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:03 INFO - 'SHELL': '/bin/bash', 01:38:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.58ZqAw1Jdk/Listeners', 01:38:03 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 01:38:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:03 INFO - 'USER': 'cltbld', 01:38:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:03 INFO - 'XPC_FLAGS': '0x0', 01:38:03 INFO - 'XPC_SERVICE_NAME': '0', 01:38:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:04 INFO - Downloading/unpacking flake8 01:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:38:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:38:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:38:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:38:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:38:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:38:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:38:08 INFO - no previously-included directories found matching 'docs/_build' 01:38:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:38:09 INFO - Running setup.py install for pep8 01:38:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:38:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:38:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:38:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:38:09 INFO - no previously-included directories found matching 'docs/_build' 01:38:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:38:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:38:09 INFO - Cleaning up... 01:38:09 INFO - Return code: 0 01:38:09 INFO - Running post-action listener: _resource_record_post_action 01:38:09 INFO - Running post-action listener: _start_resource_monitoring 01:38:09 INFO - Starting resource monitoring. 01:38:09 INFO - ##### 01:38:09 INFO - ##### Running install step. 01:38:09 INFO - ##### 01:38:09 INFO - Running pre-action listener: _resource_record_pre_action 01:38:09 INFO - Running main action method: install 01:38:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:38:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:38:09 INFO - Reading from file tmpfile_stdout 01:38:09 INFO - Detecting whether we're running mozinstall >=1.0... 01:38:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:38:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:38:09 INFO - Reading from file tmpfile_stdout 01:38:09 INFO - Output received: 01:38:09 INFO - Usage: mozinstall [options] installer 01:38:09 INFO - Options: 01:38:09 INFO - -h, --help show this help message and exit 01:38:09 INFO - -d DEST, --destination=DEST 01:38:09 INFO - Directory to install application into. [default: 01:38:09 INFO - "/builds/slave/test"] 01:38:09 INFO - --app=APP Application being installed. [default: firefox] 01:38:09 INFO - mkdir: /builds/slave/test/build/application 01:38:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:38:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 01:38:31 INFO - Reading from file tmpfile_stdout 01:38:31 INFO - Output received: 01:38:31 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 01:38:31 INFO - Running post-action listener: _resource_record_post_action 01:38:31 INFO - ##### 01:38:31 INFO - ##### Running run-tests step. 01:38:31 INFO - ##### 01:38:31 INFO - Running pre-action listener: _resource_record_pre_action 01:38:31 INFO - Running main action method: run_tests 01:38:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:38:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:38:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:38:31 INFO - 2016-06-07 01:38:31.969 screenresolution[2281:20013] starting screenresolution argv=screenresolution get 01:38:31 INFO - 2016-06-07 01:38:31.971 screenresolution[2281:20013] Display 0: 1600x1200x32@60 01:38:31 INFO - 2016-06-07 01:38:31.977 screenresolution[2282:20016] starting screenresolution argv=screenresolution list 01:38:31 INFO - Available Modes on Display 0 01:38:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:38:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:38:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:38:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:38:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:38:32 INFO - Intel Iris: 01:38:32 INFO - Chipset Model: Intel Iris 01:38:32 INFO - Type: GPU 01:38:32 INFO - Bus: Built-In 01:38:32 INFO - VRAM (Dynamic, Max): 1536 MB 01:38:32 INFO - Vendor: Intel (0x8086) 01:38:32 INFO - Device ID: 0x0a2e 01:38:32 INFO - Revision ID: 0x0009 01:38:32 INFO - Displays: 01:38:32 INFO - Display: 01:38:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:38:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:38:32 INFO - Display Serial Number: 1600x1200 60 01:38:32 INFO - Main Display: Yes 01:38:32 INFO - Mirror: Off 01:38:32 INFO - Online: Yes 01:38:32 INFO - Rotation: Supported 01:38:32 INFO - Return code: 0 01:38:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:38:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:38:32 INFO - Python 2.7.3 01:38:32 INFO - Return code: 0 01:38:32 INFO - grabbing minidump binary from tooltool 01:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:32 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 0x104952e00>, '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 0x1047bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10494db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:38:32 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 01:38:32 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 01:38:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:38:32 INFO - Return code: 0 01:38:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:38:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:38:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:38:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:38:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:38:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:38:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:38:33 INFO - Return code: 0 01:38:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0188', '--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 01:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0188 --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 01:38:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqMqFTMSco/Render', 01:38:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:33 INFO - 'HOME': '/Users/cltbld', 01:38:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:33 INFO - 'LOGNAME': 'cltbld', 01:38:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:38:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:33 INFO - 'MOZ_NO_REMOTE': '1', 01:38:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:38:33 INFO - 'NO_EM_RESTART': '1', 01:38:33 INFO - 'PAGER': '/bin/cat', 01:38:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:33 INFO - 'PWD': '/builds/slave/test', 01:38:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:38:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:33 INFO - 'SHELL': '/bin/bash', 01:38:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.58ZqAw1Jdk/Listeners', 01:38:33 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 01:38:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:33 INFO - 'USER': 'cltbld', 01:38:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:33 INFO - 'XPC_FLAGS': '0x0', 01:38:33 INFO - 'XPC_SERVICE_NAME': '0', 01:38:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0188', '--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 01:38:33 INFO - mozversion application_buildid: 20160606120332 01:38:33 INFO - mozversion application_changeset: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 01:38:33 INFO - mozversion application_display_name: Firefox 01:38:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:38:33 INFO - mozversion application_name: Firefox 01:38:33 INFO - mozversion application_remotingname: firefox 01:38:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:38:33 INFO - mozversion application_vendor: Mozilla 01:38:33 INFO - mozversion application_version: 48.0 01:38:33 INFO - mozversion platform_buildid: 20160606120332 01:38:33 INFO - mozversion platform_changeset: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 01:38:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:38:33 INFO - mozversion platform_version: 48.0 01:38:33 INFO - using testdate: 1465288713 01:38:33 INFO - actual date: 1465288713 01:38:33 INFO - starting webserver on 'localhost:53356' 01:38:33 INFO - SUITE-START | Running 2 tests 01:38:33 INFO - TEST-START | dromaeo_css 01:38:33 INFO - operating with platform_type : mac_ 01:38:33 INFO - Initialising browser for dromaeo_css test... 01:38:33 INFO - TEST-INFO | started process 2300 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpRnCjrD/profile http://localhost:53356/getInfo.html) 01:38:35 INFO - PROCESS | 2300 | __metrics Screen width/height:1600/1200 01:38:35 INFO - PROCESS | 2300 | colorDepth:24 01:38:35 INFO - PROCESS | 2300 | Browser inner width/height: 1024/689 01:38:35 INFO - PROCESS | 2300 | __metrics 01:38:35 INFO - PROCESS | 2300 | 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" 01:38:35 ERROR - PROCESS | 2300 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:38:36 INFO - TEST-INFO | 2300: exit 0 01:38:36 INFO - Browser initialized. 01:38:36 INFO - Running cycle 1/1 for dromaeo_css test... 01:38:36 INFO - TEST-INFO | started process 2303 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpRnCjrD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:38:48 INFO - PROCESS | 2303 | RSS: Main: 161529856 01:38:48 INFO - PROCESS | 2303 | 01:39:39 INFO - PROCESS | 2303 | 1465288779764 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] 01:41:50 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53356/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53356/tests/dromaeo/cssquery-ext.html) 01:41:51 INFO - PROCESS | 2303 | RSS: Main: 256069632 01:41:51 INFO - PROCESS | 2303 | 01:44:54 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53356/tests/dromaeo/cssquery-ext.html (next: http://localhost:53356/tests/dromaeo/cssquery-jquery.html) 01:44:54 INFO - PROCESS | 2303 | RSS: Main: 289218560 01:44:54 INFO - PROCESS | 2303 | 01:47:56 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53356/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53356/tests/dromaeo/cssquery-mootools.html) 01:47:57 INFO - PROCESS | 2303 | RSS: Main: 306647040 01:47:57 INFO - PROCESS | 2303 | 01:50:59 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53356/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53356/tests/dromaeo/cssquery-prototype.html) 01:50:59 INFO - PROCESS | 2303 | RSS: Main: 304336896 01:50:59 INFO - PROCESS | 2303 | 01:54:03 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53356/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53356/tests/dromaeo/cssquery-yui.html) 01:54:03 INFO - PROCESS | 2303 | RSS: Main: 269307904 01:54:03 INFO - PROCESS | 2303 | 01:57:06 INFO - PROCESS | 2303 | Cycle 1(1): loaded http://localhost:53356/tests/dromaeo/cssquery-yui.html (next: http://localhost:53356/tests/dromaeo/cssquery-dojo.html) 01:57:06 INFO - PROCESS | 2303 | RSS: Main: 340365312 01:57:06 INFO - PROCESS | 2303 | 01:57:06 INFO - PROCESS | 2303 | __start_tp_report 01:57:06 INFO - PROCESS | 2303 | _x_x_mozilla_page_load 01:57:06 INFO - PROCESS | 2303 | _x_x_mozilla_page_load_details 01:57:06 INFO - PROCESS | 2303 | |i|pagename|runs| 01:57:06 INFO - PROCESS | 2303 | |0;dojo.html;3499.42259527178;3544.8582056717732;3565.910852228694;3578.2127931855;3627.564692236932;5923.962858167615;5934.910976335353;5944.494717948979;5945.16767652529;5997.4902133318665;5916.88166236675;5984.431479009498;5991.071383935486;6000.309964354101;6010.939890601093;5222.451642577513;5345.1447768357075;5355.518003379695;5374.381946076212;5428.4300148484435;5351.7324133793345;5400.810971615994;5405.135178371462;5405.621606487528;5409.864753381157;5308.761105750251;5379.462053794608;5393.757280922348;5397.811076612319;5410.1073322901675;5381.1121165007535;5410.3507579090365;5443.374011988632;5443.646162999393;5467.58993075517;5120.61595380348;5253.08071087562;5319.5744340452675;5320.388155362106;5343.145096784496;5697.886042279172;5755.223044888929;5770.105633626795;5795.072788353843;5796.1595568642315;6222.097795819626;6254.093156492283;6254.74981000764;6274.278457977345;6275.843103922392;6135.140800782634;6245.156903817971;6296.716647750863;6302.401271879165;6305.085762564402;6056.454919057262;6060.666663333471;6073.574849760563;6089.117078023662;6103.633781973096;6369.8726025480155;6370.968145159244;6380.489560835122;6382.266039405527;6398.200224971879;6131.14164017038;6230.190075290183;6282.4974002079725;6307.779227727007;6319.33646967071;6278.372162783685;6296.748130074746;6297.4962003039645;6297.937020629735;6305.148804911279;6192.102145188923;6267.091271765568;6275.560710750295;6285.717142728588;6288.748450062038;6208.441240288305;6224.346443623354;6259.374062593704;6271.9686401568615;6318.273398559132;5004.249362595567;5034.194528875362;5040.84877453677;5045;5065.062963351792;4543.568361005699;4544.272916333371;4555.202839503074;4577.29051996941;4598.977005114953;5860.179574859523;5946.851328716817;5995.880082398327;6063.242094738158;6092.3603021682975;6191.230006342012;6238.532110091761;6250.718717657625;6258.217722784652;6286.371362863677;6028.125921741323;6043.909341359883;6051.425114614105;6052.978485263027;6068.33248342682;5398.6220964532895;5465.07093794056;5473.67157970523;5522.585806064561;5535.197396377503;6428.453581445442;6478.546501744832;6522.673866306761;6523.510736694767;6530.608163510205;5510.641808282448;6193.040078787795;6262.624242545462;6263.467605253604;6270.404311590391;6418.646974416265;6479.676016199077;6498.122753428227;6501.934980650133;6517.576357536745;6230.657313847782;6249.96875015622;6257.56197066201;6267.62394256346;6278.686065696788;5710.114932185518;5811.651300921789;6262.15460912771;6263.154474145932;6268.655223962726;6168.660723660242;6262.68686565679;6263;6265.404786545271;6276.089966954857;6264.404881536247;6265.843353916189;6275.121482992294;6282.497400207881;6286.591371560834;5984.790532331347;6007.219061521974;6104.725287361991;6155.1382806406245;6203.720832562455;6107.994843641952;6133.824358647991;6241.625502469867;6265.937340626535;6275.5920865145445;6159.599626024294;6162.352952939877;6207;6209.316975132822;6214.25428948529 01:57:06 INFO - PROCESS | 2303 | |1;ext.html;530.9460720469867;604.2688347100008;683.0232767142984;689.3485656055027;689.8103021669043;32432.675673243262;39890.8005459973;40176;40194.59805401945;40469.988250293754;46213;46690.29964550534;46732.06535869281;46812;46881.531184688145;9110;10016.849747253797;10176.898231017669;10191.643292484765;10193.1845452364;11902.702432439215;12210.694732631666;12229.694257643541;12251.816222756666;12253.448594813255;12057.457414416329;12149.392530373447;12149.574764883231;12157.51369945201;12178.756424871497;9299;12029.51881924722;12129.575464858732;12195.878041219607;12346.5061397544;11853.525858965631;11984.880151198464;11988.580399685969;11994.100442466763;12006.339651319175;39365.80317098425;39704.404433933516;39730;39822.40266396006;39842.20315593672;3477.443609022544;3635.94546081809;3767.303048935928;3888.591697871711;3920.5295364556437;28311.433771324664;28951.697173627028;28999.565006524917;29032.709672903213;29636.85181574078;2798.524250877356;2849.301921029361;2899.492588796952;2917.6498820141505;3015.803972741765;457587;459028;461456;462240.6887965539;462650;65669;65799.67100164469;65836.34163658398;65900.34099658942;65977.67011164913;69526;69713;69813;69980;69993.65003175053;16999;18893.811061889206;19122.426327210207;19152.61694766097;19231.230750770093;12966;14499.202543859978;14628.268586570628;14863.108213507225;14870;14466.927665361816;17522;17553.648927021644;17695.203715832817;17744.846584971936;7183.856322873513;7295.088113985752;7324.011258480037;7325.447158128303;7392.519486233377;931.2317338196016;1053.836655318427;1056.8361903904906;1069.5240617924949;1102.1678632632472;24322;30956.845215773777;31345.686543134732;31380.529292060637;33064.173395665304;1008.5965613754557;1182.6984119049587;1189.9107566932514;1202.374765122149;1219.4329636718792;13226.73546529064;14428.927855360656;15708.764368534481;15721.606959826096;16070.196490175444;611591;616340;618312;621025;622350;64741.67629161918;65013.02480462797;65056;65059.04822855322;65313;1455.6870272891379;1499.5276487906492;1581.7311057120316;1582.5806161367016;1584.7543630737255;30225.52664188352;31603;31891.840540797148;32324;33036.33927321488;56650.43349566452;57096.85806283768;57778.133327999276;57797.71101144636;57818;519871;533525;535830;536594;537047;37147.25705485929;40220;45489.77255113703;46384;46580;47079;47120;47730.522694772604;48196;48848.51151488582;38603.420948686355;40866.38700419437;41272.1745565093;41440;41792.3731144027;39737;39841.40237896376;40144.79927600343;40169.1966160681;40915.7954210227;40050.79974600108;40406;40675.59324406718;40933.59066409417;41501.58498415098;32526.02421927346;33961.39636959874;33999.83000084984;34079.97760067202;34518.48222276718;25850.35374115662;25924.870375648003;26015.479690405708;26265;26308.21075367742 01:57:06 INFO - PROCESS | 2303 | |2;jquery.html;421.0715372603409;421.3658444041717;422.11988005009533;424.3931178414866;433.2180414352095;21393.82333971631;21762.911854407277;22035.33893983181;22376.881155942177;22874.77125228747;21622.89188554059;21874.453138671543;22228.333150005485;22492.550148997012;22523.211687590938;6071.817845464643;6260.280067792194;6272.404121608462;6283.994560870262;6288.182536270278;4569.337446070318;4809.326694262789;6214.5649804513705;6296.181496405461;6999.860002799941;6658.966705166467;6886.793396198122;6894.413974812147;6921.619310937896;6946.6179360135175;5300.761465734032;6327.620342779402;6335.447815285284;6891.379775820175;6911.067005954207;4165.562615925314;5940.34656187819;6177.567570270083;6187.226596675416;6207.131001659771;13927.512537061255;14119.294035298193;14168.787468187986;14174.362153703109;26822.792974316006;2151.537419454825;2247.741509726386;2355.3993731598503;2877.963932984124;2884.6971068037765;10363.740906477324;10416.479176041168;10839.729006774814;11979;15902.363905443768;1866.4120801947342;1870.6165236126562;1909.8376637985648;1935.6902895536787;1943.640426521098;115331.42334288274;125115;127813;128122.07816882755;128238.35880820629;11833.585824496102;11840.822387664191;12079.75840483203;12123.757524849454;12266.386680665932;15764.211789410483;15781.842181578037;15807.683846323009;15829.841701582836;15843.603909902346;9005.099490050943;9265.490398028038;9334.113259240361;9434.433933963985;9455.952720236355;8866.778330541789;9383.483908385104;9416.387934784218;9423.34036617444;9487.335886488017;3818.59904710007;4835.782389792468;4906.11689895815;4910.803567857317;4957.801687932514;2018.2128969701828;2040.877547347164;2056.619525387808;2063.8658487198286;2073.154892145991;896.8923729152413;902.7968707040864;937.4281688170211;950.7860731335533;989.2549859244315;21240.389133847282;21910.89044554767;22007.449813754785;22311.4341850686;22336.66495002544;1046.2676126711333;1047.1308813684775;1054.1830081686753;1065.1053115383115;1128.328644456547;10015.748031496063;11223.887761122447;11540.422978851024;11611.187216894736;11714.76570468603;544650.2767486137;630587;637497;650878;671225;77376;78059.60970195226;100901;134293;145250;914.963401463934;921.2445794448622;934.4066517761271;945.3713280668278;948.5304774136846;18637.44087677372;19083.522911926757;19259.422217333504;19278.421647350602;19443.519572228295;53098.93802123859;53396.93206135933;53623.731881341904;54052;54550.727246363516;73466;75240.06815799428;75439.24560754323;78147.218527814;78221;8454;8496.06543280251;8509.957450212709;8706.216440520384;8775.210231079234;9604.51977401141;12654.43055062506;13436.798448023092;13457;14026.649333766738;11711.063114950613;11815.822762658396;11840.28958262507;11887.702807429883;12165.513379465076;11556.422178890854;11740.647780566596;11769.234999724991;12010.33943133136;12037.699057523632;11887.227330223508;11971.760564788481;12082.75834483323;12165.817512737493;12183.390830458618;8580.270676992526;8647.203475641094;8683.478991260545;8740.737777866674;8874.511901845202;8622.870656940026;10983.450827458755;11918.344491052729;12036;12132.514699412277 01:57:06 INFO - PROCESS | 2303 | |3;mootools.html;1469.0744830756635;1623.1965177237266;1653.099061011748;1933.9806601933985;2033.4306394209627;8231.259186673198;8844.15980481854;8948.328875334344;8967.641294348234;8970.416922900024;8627.611757470913;8861.955690221555;8890;8901.332400070005;8904.643814247422;2549.0058877037923;2576.6779152605923;2577.1495406515805;2577.793776497885;2579.1617724239604;2498.3379404457833;2562.6796650418696;2564.8974041038337;2567.922962311124;2573.318070711263;2529.4941011797623;2555.1823416506727;2571.961420578693;2576.021111977446;2585.9482810343784;2332.682034650417;2349.7297810751725;2524.066095544642;2567.679040119985;2572.254046326563;2520.7227205007434;2559.5264875998;2561.820672552922;2564.743525647439;2576.780973617245;8828.426152300144;9036.728898133066;9117.908820911773;9123.224525915306;9125.589348479269;5592.692401917933;5758.971205143947;5813.767449302023;5837.941620583782;5848.88302233953;3581.4090675038588;3602.9279414411567;3640.7633503822167;3721.776693398405;3792.9620703792884;964.9614015439374;1041.7760181561;1055.1242468750918;1055.7278479432266;1103.0458653264868;11471.48378322969;11563.074954003743;11756.235844670155;11793.410329483491;11795.351255680935;4688.2733176357715;4705.576498115186;4715.882102947454;4778.737169455644;4788.545088216614;9414.529273536296;9424.246060315158;9435.622575097057;9438.292128090421;9461.621535138655;5536.916946245809;5537.086380747131;5538.667679939216;5538.975289571362;5553.278073850373;4636.281376386665;4792.9281060784115;4998.125328067574;5162.716050617177;5167.689938603696;3271.9018429447156;4013.3177359848896;4061.431399604058;4101.733387329814;4144.958550414518;1085.3921803789904;1227.8642255913244;1235.734317121823;1252.2423933520272;1256.8051951947464;956.4978386347224;980.8626792249091;995.6117114325419;1003.6136087606324;1017.3285631483186;6106.877862442726;6164.044573091178;6186.721597528122;6233.158523599347;6235.407636274546;462.0873774295806;479.8344571122957;480.5434836904954;494.32277779441677;495.68523987268344;4035.152617950205;4092.508898932147;4107.97946010274;4130;4140.358244472111;10549.367037977592;10885.401302928256;10980.176486763525;10983.340999540053;10987.560497580007;10699.14406847466;10794.838077428845;10832.295900766425;10849.728756781144;10862.293950893167;8404.747857564284;8476.152384761597;8482.703105391281;8493.447925884675;8508.234258916727;5734.885302293847;5829.271341082364;5836;5971.701414929149;6049.455549000611;9638.469884156159;9708.368956017835;9709.6601618943;9782.608695652094;9811.656592019244;9462.716118516455;9885.406875587487;9956.452395118338;9977;9981.550830212513;6657.500687448558;6786.830329241809;7058.3647471725735;7144.64276786169;7232.312930271616;8486.74539763808;8501.532415716947;8560.229579337889;8575.699850505202;8599.52702601363;7478.177400486051;7619.276168763959;7635.88546171819;7700.075990881131;7718.421118416029;7186.425085993003;7244.166920804175;7276.8908466374105;7374.594397307985;7378.778636640909;7209.819754506179;7267.563946163035;7307.525010874276;7309.269073092648;7328.3404493595835;4991.126552853309;5015.448300686849;5088.669236499616;5128.58971282304;5196.142636464941;4939.431965324034;5044.772985215601;5123.3339665843205;5160.48395160481;5395.81114660985 01:57:06 INFO - PROCESS | 2303 | |4;prototype.html;332.0983529716819;335.08521735661645;340.87001589730045;342.80288833920486;345.43176474699106;6787.389134977851;6838.0768596239495;6845.760398386051;6870.38166565009;6896.689648965796;6785.1179346684985;6789.321067893221;6807.829804254896;6829.6926638301275;6834.453243740501;4813.831515896944;4908.926366104493;4914.655974081816;4992.87517812054;5053.418856831457;4967.279744437054;5024.447310795809;5030.773615187307;5032.4967503249745;5032.9748351258195;4973.701577905319;4983.700977941335;4989.825356112537;4993.950060499385;5071.797128114871;4793.760311984404;4847.951520484785;4960.23116416956;4966.627502937258;4980.477049909779;4278.657707383433;4287.506936702257;4291.120320334324;4291.849785257501;4304.548022457629;6490.253620833618;6543.770968016144;6599.274079851212;6601.966990165019;6607.80176594703;5936.1095835625;5937.960856850034;5941.405859414067;5942.138389933479;5945.375735547748;6637.800865974028;6668.833279168011;7248.963755181243;7254.129504459499;7259.818504537376;4660.277656963176;4670.509596492353;4683.695559788603;4691.976540117277;4698.013417182396;7536.321731044178;7654.693812247503;7659.080910290745;7673.808154796119;7678.462507624468;4743.549362810528;4743.905121897612;4746.264329029006;4751.64362672801;4758.333833263277;4803.495632958489;4805.519448055236;4817.8313759018265;4826.32431459596;4827.468978412442;4726.243800991825;5583.0787919992745;5791.594588378857;5805.7387417566315;5817.360090390053;7274.527155734861;7290;7291.598962057032;7306.232845551247;7320.975063491115;1623.2614160556918;1663.8502534771928;1664.7419649954277;1665.5919299771633;1673.6820004199162;879.6745204274331;1036.9118624916816;1064.6380230721593;1066.8559744434558;1069.417167643636;6645.202575690948;6787;6831.795046148623;6840.076589660432;6921;7535.698572057166;7556.395488360918;7560.773176804704;7568.978187944557;7589.051368578927;6882.414994725505;6894.069300644449;6904.4821638377325;6910.689018994158;6917.965410172917;3218.3563287342627;4007.5992400760274;4012.25773231953;4013.3779264214095;4021.235965166609;7624.42816788743;7888.566128862853;7894.447388682737;7906.7627971160955;7928.841423171504;7805.609719514002;7810.804729881685;7816.4757872215505;7826.608669566499;7851.607419628996;7904.6838126474295;7908.683652653829;7915.841683166304;7923.128455869965;7929.1277959424415;7275.126984761862;7494.175640679412;7527.247275272429;7534.35957943559;7556.8866467001935;7390.29792169743;7448.478606497493;7465.589392583242;7468.813279668052;7471.663775130023;7290.270972902667;7766.417518686008;7882.921170788448;7895.447318687637;7906;4758.214894542501;4776.713397196179;4777.784999675093;4779.402574678165;4784.306275590089;7297.343239108506;7538.547687138789;7557.470977031775;7571.091469023752;7573.545587264782;7272.89090663651;7290.234525374759;7294.635268236673;7305.707771689285;7326;5891.94108058931;7303.963480182565;7317.524360916736;7319.34125928669;7322.121345438369;5886.941130588811;7070.68181931804;7147.499675022698;7164.820879478055;7181.461390395846;6348.587341822767;7038.824029399306;7304;7336.449766267445;7356.227596102546;6859.07402500676;6960.825979350354;7035.542689725152;7089.432845372461;7219.061522002106 01:57:06 INFO - PROCESS | 2303 | |5;yui.html;710.7547895975888;736.5948728199489;781.6912319633744;797.4776521378495;797.892284541587;15439.382424703012;15622.375104995815;15669.059856408623;15678.372865085397;15680.686386272268;14293.213873236968;14488.782668259984;14510.854891451083;14517.20155391453;14517.564473065824;786.6813940354151;808.1756608259572;963.9903600964005;995.4176806568166;995.8954309797475;963.9855402168973;975.0054943957159;976.3019441099613;976.990230097697;977.5258999385293;824.5382585751968;1042.1506472225112;1044.968650940473;1047.0419566097012;1047.6752206815872;826.5371392020458;833.1002517281352;837.2924878477677;1008.6873069348526;1041.8697662792151;780.157429975625;782.0927723840375;782.3662833105203;783.2363445640511;783.9333656639193;15407.383704651913;15459.61350966235;15470.845291547053;15480.5355839325;15540.378384864593;12889.806652900214;12985.740285194242;13204;13269.270190139538;13562.864371356358;10211.285210035301;10263.46229267299;10442.843357349646;10646.680599582025;11052.613158539412;3554.3424466473784;3566.9108272293142;3595.7123430125525;3631.382664946965;3704.351738445788;86171.5691421539;86664;88983;89372.10627893703;89864.55067724685;9773.21814254858;9855.26085543587;9886.011398860057;9928.453935033642;9976.950115249523;23067.307980760605;23874.806259686946;24078.39804004914;24101.03595856146;24109.794510274765;7804.180561041123;7839.6472158752995;7952;7958.403119766041;8214.26071653554;3985.362342025262;4089.9795501022304;4251.3622956556765;4313.525512193656;4374.212641724456;3822;3880.7477513961503;3883.0874744435037;3883.37865941448;3896.551896531935;608.558794873713;699.8845190543606;708.0830324729487;714.8348192446383;720.5748608321115;522.811787756415;536.6940843719043;578.320473443702;592.6473748119862;598.3537779198455;8117.391195660349;8551.486910785372;8769.342299327576;9035.36752427337;9160.6793762218;625.3308959413384;636.5671343486381;644.0628884972353;646.2955378637308;648.8896887529131;3824.388097904322;3976.522817261889;4040.4545386372465;4067.613576710208;4251.383549385384;82881.3423731522;90395.09604903999;92362;92708.53645731728;92763.60854587186;71928.20179495554;73015.63492182505;76047;78340.60829695815;78398.6080069596;64948.67525662341;65998.6800263992;66936.66531667311;67082;70034.64982674952;8420.873686894824;8698.130186981505;8710.869336960077;8836.690715824916;8940.061293564342;43806;44684.659460216244;44691;44949.32576011297;45615;64531.677341612994;65331.346686532524;65963;67903;68149.65925170343;11674.182807203415;11927.940360298144;12041.518339266331;12086.758264834478;12154.817677734663;10081.344712593658;11597.594084207012;12196.756064878475;12225.327606981702;12308.753824923631;11504.086625543763;11780.057595392176;12157.148999569945;12361.690957726129;12411.875881241072;11625.865019718864;12176.964957978671;12201.755964880474;12205.962493187822;12306.323152226714;11394.715132121763;12002;12235.143539952118;12362.690932726753;12379.814302785646;8807.955960220157;10007.299489035697;10210.030047145508;10216.540255688364;10355.43045132525;8961.820763584561;9508.477033763209;9539.332246742939;9972.700818975442;9973.202143828332 01:57:06 INFO - PROCESS | 2303 | __end_tp_report 01:57:06 INFO - PROCESS | 2303 | __start_cc_report 01:57:06 INFO - PROCESS | 2303 | _x_x_mozilla_cycle_collect,1112 01:57:06 INFO - PROCESS | 2303 | __end_cc_report 01:57:06 INFO - PROCESS | 2303 | __startTimestamp1465289826631__endTimestamp 01:57:06 INFO - PROCESS | 2303 | 01:57:06 INFO - PROCESS | 2303 | ------- Summary: start ------- 01:57:06 INFO - PROCESS | 2303 | Number of tests: 6 01:57:06 INFO - PROCESS | 2303 | 01:57:06 INFO - PROCESS | 2303 | [#0] dojo.html Cycles:165 Average:5875.37 Median:6131.14 stddev:615.02 (10.0%) stddev-sans-first:587.98 01:57:06 INFO - PROCESS | 2303 | Values: 3499.4 3544.9 3565.9 3578.2 3627.6 5924.0 5934.9 5944.5 5945.2 5997.5 5916.9 5984.4 5991.1 6000.3 6010.9 5222.5 5345.1 5355.5 5374.4 5428.4 5351.7 5400.8 5405.1 5405.6 5409.9 5308.8 5379.5 5393.8 5397.8 5410.1 5381.1 5410.4 5443.4 5443.6 5467.6 5120.6 5253.1 5319.6 5320.4 5343.1 5697.9 5755.2 5770.1 5795.1 5796.2 6222.1 6254.1 6254.7 6274.3 6275.8 6135.1 6245.2 6296.7 6302.4 6305.1 6056.5 6060.7 6073.6 6089.1 6103.6 6369.9 6371.0 6380.5 6382.3 6398.2 6131.1 6230.2 6282.5 6307.8 6319.3 6278.4 6296.7 6297.5 6297.9 6305.1 6192.1 6267.1 6275.6 6285.7 6288.7 6208.4 6224.3 6259.4 6272.0 6318.3 5004.2 5034.2 5040.8 5045.0 5065.1 4543.6 4544.3 4555.2 4577.3 4599.0 5860.2 5946.9 5995.9 6063.2 6092.4 6191.2 6238.5 6250.7 6258.2 6286.4 6028.1 6043.9 6051.4 6053.0 6068.3 5398.6 5465.1 5473.7 5522.6 5535.2 6428.5 6478.5 6522.7 6523.5 6530.6 5510.6 6193.0 6262.6 6263.5 6270.4 6418.6 6479.7 6498.1 6501.9 6517.6 6230.7 6250.0 6257.6 6267.6 6278.7 5710.1 5811.7 6262.2 6263.2 6268.7 6168.7 6262.7 6263.0 6265.4 6276.1 6264.4 6265.8 6275.1 6282.5 6286.6 5984.8 6007.2 6104.7 6155.1 6203.7 6108.0 6133.8 6241.6 6265.9 6275.6 6159.6 6162.4 6207.0 6209.3 6214.3 01:57:06 INFO - PROCESS | 2303 | 01:57:06 INFO - PROCESS | 2303 | [#1] ext.html Cycles:180 Average:69414.70 Median:20457.28 stddev:143939.44 (703.6%) stddev-sans-first:144250.31 01:57:06 INFO - PROCESS | 2303 | Values: 530.9 604.3 683.0 689.3 689.8 32432.7 39890.8 40176.0 40194.6 40470.0 46213.0 46690.3 46732.1 46812.0 46881.5 9110.0 10016.8 10176.9 10191.6 10193.2 11902.7 12210.7 12229.7 12251.8 12253.4 12057.5 12149.4 12149.6 12157.5 12178.8 9299.0 12029.5 12129.6 12195.9 12346.5 11853.5 11984.9 11988.6 11994.1 12006.3 39365.8 39704.4 39730.0 39822.4 39842.2 3477.4 3635.9 3767.3 3888.6 3920.5 28311.4 28951.7 28999.6 29032.7 29636.9 2798.5 2849.3 2899.5 2917.6 3015.8 457587.0 459028.0 461456.0 462240.7 462650.0 65669.0 65799.7 65836.3 65900.3 65977.7 69526.0 69713.0 69813.0 69980.0 69993.7 16999.0 18893.8 19122.4 19152.6 19231.2 12966.0 14499.2 14628.3 14863.1 14870.0 14466.9 17522.0 17553.6 17695.2 17744.8 7183.9 7295.1 7324.0 7325.4 7392.5 931.2 1053.8 1056.8 1069.5 1102.2 24322.0 30956.8 31345.7 31380.5 33064.2 1008.6 1182.7 1189.9 1202.4 1219.4 13226.7 14428.9 15708.8 15721.6 16070.2 611591.0 616340.0 618312.0 621025.0 622350.0 64741.7 65013.0 65056.0 65059.0 65313.0 1455.7 1499.5 1581.7 1582.6 1584.8 30225.5 31603.0 31891.8 32324.0 33036.3 56650.4 57096.9 57778.1 57797.7 57818.0 519871.0 533525.0 535830.0 536594.0 537047.0 37147.3 40220.0 45489.8 46384.0 46580.0 47079.0 47120.0 47730.5 48196.0 48848.5 38603.4 40866.4 41272.2 41440.0 41792.4 39737.0 39841.4 40144.8 40169.2 40915.8 40050.8 40406.0 40675.6 40933.6 41501.6 32526.0 33961.4 33999.8 34080.0 34518.5 25850.4 25924.9 26015.5 26265.0 26308.2 01:57:06 INFO - PROCESS | 2303 | 01:57:06 INFO - PROCESS | 2303 | [#2] jquery.html Cycles:180 Average:35632.48 Median:22698.99 stddev:104363.92 (459.8%) stddev-sans-first:104623.20 01:57:06 INFO - PROCESS | 2303 | Values: 421.1 421.4 422.1 424.4 433.2 21393.8 21762.9 22035.3 22376.9 22874.8 21622.9 21874.5 22228.3 22492.6 22523.2 6071.8 6260.3 6272.4 6284.0 6288.2 4569.3 4809.3 6214.6 6296.2 6999.9 6659.0 6886.8 6894.4 6921.6 6946.6 5300.8 6327.6 6335.4 6891.4 6911.1 4165.6 5940.3 6177.6 6187.2 6207.1 13927.5 14119.3 14168.8 14174.4 26822.8 2151.5 2247.7 2355.4 2878.0 2884.7 10363.7 10416.5 10839.7 11979.0 15902.4 1866.4 1870.6 1909.8 1935.7 1943.6 115331.4 125115.0 127813.0 128122.1 128238.4 11833.6 11840.8 12079.8 12123.8 12266.4 15764.2 15781.8 15807.7 15829.8 15843.6 9005.1 9265.5 9334.1 9434.4 9456.0 8866.8 9383.5 9416.4 9423.3 9487.3 3818.6 4835.8 4906.1 4910.8 4957.8 2018.2 2040.9 2056.6 2063.9 2073.2 896.9 902.8 937.4 950.8 989.3 21240.4 21910.9 22007.4 22311.4 22336.7 1046.3 1047.1 1054.2 1065.1 1128.3 10015.7 11223.9 11540.4 11611.2 11714.8 544650.3 630587.0 637497.0 650878.0 671225.0 77376.0 78059.6 100901.0 134293.0 145250.0 915.0 921.2 934.4 945.4 948.5 18637.4 19083.5 19259.4 19278.4 19443.5 53098.9 53396.9 53623.7 54052.0 54550.7 73466.0 75240.1 75439.2 78147.2 78221.0 8454.0 8496.1 8510.0 8706.2 8775.2 9604.5 12654.4 13436.8 13457.0 14026.6 11711.1 11815.8 11840.3 11887.7 12165.5 11556.4 11740.6 11769.2 12010.3 12037.7 11887.2 11971.8 12082.8 12165.8 12183.4 8580.3 8647.2 8683.5 8740.7 8874.5 8622.9 10983.5 11918.3 12036.0 12132.5 01:57:06 INFO - PROCESS | 2303 | 01:57:06 INFO - PROCESS | 2303 | [#3] mootools.html Cycles:180 Average:5789.28 Median:5144.54 stddev:3180.54 (61.8%) stddev-sans-first:3172.89 01:57:06 INFO - PROCESS | 2303 | Values: 1469.1 1623.2 1653.1 1934.0 2033.4 8231.3 8844.2 8948.3 8967.6 8970.4 8627.6 8862.0 8890.0 8901.3 8904.6 2549.0 2576.7 2577.1 2577.8 2579.2 2498.3 2562.7 2564.9 2567.9 2573.3 2529.5 2555.2 2572.0 2576.0 2585.9 2332.7 2349.7 2524.1 2567.7 2572.3 2520.7 2559.5 2561.8 2564.7 2576.8 8828.4 9036.7 9117.9 9123.2 9125.6 5592.7 5759.0 5813.8 5837.9 5848.9 3581.4 3602.9 3640.8 3721.8 3793.0 965.0 1041.8 1055.1 1055.7 1103.0 11471.5 11563.1 11756.2 11793.4 11795.4 4688.3 4705.6 4715.9 4778.7 4788.5 9414.5 9424.2 9435.6 9438.3 9461.6 5536.9 5537.1 5538.7 5539.0 5553.3 4636.3 4792.9 4998.1 5162.7 5167.7 3271.9 4013.3 4061.4 4101.7 4145.0 1085.4 1227.9 1235.7 1252.2 1256.8 956.5 980.9 995.6 1003.6 1017.3 6106.9 6164.0 6186.7 6233.2 6235.4 462.1 479.8 480.5 494.3 495.7 4035.2 4092.5 4108.0 4130.0 4140.4 10549.4 10885.4 10980.2 10983.3 10987.6 10699.1 10794.8 10832.3 10849.7 10862.3 8404.7 8476.2 8482.7 8493.4 8508.2 5734.9 5829.3 5836.0 5971.7 6049.5 9638.5 9708.4 9709.7 9782.6 9811.7 9462.7 9885.4 9956.5 9977.0 9981.6 6657.5 6786.8 7058.4 7144.6 7232.3 8486.7 8501.5 8560.2 8575.7 8599.5 7478.2 7619.3 7635.9 7700.1 7718.4 7186.4 7244.2 7276.9 7374.6 7378.8 7209.8 7267.6 7307.5 7309.3 7328.3 4991.1 5015.4 5088.7 5128.6 5196.1 4939.4 5044.8 5123.3 5160.5 5395.8 01:57:06 INFO - PROCESS | 2303 | 01:57:06 INFO - PROCESS | 2303 | [#4] prototype.html Cycles:180 Average:5946.76 Median:6830.74 stddev:1918.70 (28.1%) stddev-sans-first:1877.24 01:57:06 INFO - PROCESS | 2303 | Values: 332.1 335.1 340.9 342.8 345.4 6787.4 6838.1 6845.8 6870.4 6896.7 6785.1 6789.3 6807.8 6829.7 6834.5 4813.8 4908.9 4914.7 4992.9 5053.4 4967.3 5024.4 5030.8 5032.5 5033.0 4973.7 4983.7 4989.8 4994.0 5071.8 4793.8 4848.0 4960.2 4966.6 4980.5 4278.7 4287.5 4291.1 4291.8 4304.5 6490.3 6543.8 6599.3 6602.0 6607.8 5936.1 5938.0 5941.4 5942.1 5945.4 6637.8 6668.8 7249.0 7254.1 7259.8 4660.3 4670.5 4683.7 4692.0 4698.0 7536.3 7654.7 7659.1 7673.8 7678.5 4743.5 4743.9 4746.3 4751.6 4758.3 4803.5 4805.5 4817.8 4826.3 4827.5 4726.2 5583.1 5791.6 5805.7 5817.4 7274.5 7290.0 7291.6 7306.2 7321.0 1623.3 1663.9 1664.7 1665.6 1673.7 879.7 1036.9 1064.6 1066.9 1069.4 6645.2 6787.0 6831.8 6840.1 6921.0 7535.7 7556.4 7560.8 7569.0 7589.1 6882.4 6894.1 6904.5 6910.7 6918.0 3218.4 4007.6 4012.3 4013.4 4021.2 7624.4 7888.6 7894.4 7906.8 7928.8 7805.6 7810.8 7816.5 7826.6 7851.6 7904.7 7908.7 7915.8 7923.1 7929.1 7275.1 7494.2 7527.2 7534.4 7556.9 7390.3 7448.5 7465.6 7468.8 7471.7 7290.3 7766.4 7882.9 7895.4 7906.0 4758.2 4776.7 4777.8 4779.4 4784.3 7297.3 7538.5 7557.5 7571.1 7573.5 7272.9 7290.2 7294.6 7305.7 7326.0 5891.9 7304.0 7317.5 7319.3 7322.1 5886.9 7070.7 7147.5 7164.8 7181.5 6348.6 7038.8 7304.0 7336.4 7356.2 6859.1 6960.8 7035.5 7089.4 7219.1 01:57:06 INFO - PROCESS | 2303 | 01:57:06 INFO - PROCESS | 2303 | [#5] yui.html Cycles:180 Average:18412.37 Median:529.75 stddev:25449.35 (4804.0%) stddev-sans-first:25486.03 01:57:06 INFO - PROCESS | 2303 | Values: 710.8 736.6 781.7 797.5 797.9 15439.4 15622.4 15669.1 15678.4 15680.7 14293.2 14488.8 14510.9 14517.2 14517.6 786.7 808.2 964.0 995.4 995.9 964.0 975.0 976.3 977.0 977.5 824.5 1042.2 1045.0 1047.0 1047.7 826.5 833.1 837.3 1008.7 1041.9 780.2 782.1 782.4 783.2 783.9 15407.4 15459.6 15470.8 15480.5 15540.4 12889.8 12985.7 13204.0 13269.3 13562.9 10211.3 10263.5 10442.8 10646.7 11052.6 3554.3 3566.9 3595.7 3631.4 3704.4 86171.6 86664.0 88983.0 89372.1 89864.6 9773.2 9855.3 9886.0 9928.5 9977.0 23067.3 23874.8 24078.4 24101.0 24109.8 7804.2 7839.6 7952.0 7958.4 8214.3 3985.4 4090.0 4251.4 4313.5 4374.2 3822.0 3880.7 3883.1 3883.4 3896.6 608.6 699.9 708.1 714.8 720.6 522.8 536.7 578.3 592.6 598.4 8117.4 8551.5 8769.3 9035.4 9160.7 625.3 636.6 644.1 646.3 648.9 3824.4 3976.5 4040.5 4067.6 4251.4 82881.3 90395.1 92362.0 92708.5 92763.6 71928.2 73015.6 76047.0 78340.6 78398.6 64948.7 65998.7 66936.7 67082.0 70034.6 8420.9 8698.1 8710.9 8836.7 8940.1 43806.0 44684.7 44691.0 44949.3 45615.0 64531.7 65331.3 65963.0 67903.0 68149.7 11674.2 11927.9 12041.5 12086.8 12154.8 10081.3 11597.6 12196.8 12225.3 12308.8 11504.1 11780.1 12157.1 12361.7 12411.9 11625.9 12177.0 12201.8 12206.0 12306.3 11394.7 12002.0 12235.1 12362.7 12379.8 8808.0 10007.3 10210.0 10216.5 10355.4 8961.8 9508.5 9539.3 9972.7 9973.2 01:57:06 INFO - PROCESS | 2303 | -------- Summary: end -------- 01:57:06 INFO - PROCESS | 2303 | 01:57:07 INFO - TEST-INFO | 2303: exit 0 01:57:07 INFO - TEST-OK | dromaeo_css | took 1113561ms 01:57:07 INFO - TEST-START | kraken 01:57:07 INFO - operating with platform_type : mac_ 01:57:07 INFO - Initialising browser for kraken test... 01:57:07 INFO - TEST-INFO | started process 2305 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpowOKic/profile http://localhost:53356/getInfo.html) 01:57:09 INFO - PROCESS | 2305 | __metrics Screen width/height:1600/1200 01:57:09 INFO - PROCESS | 2305 | colorDepth:24 01:57:09 INFO - PROCESS | 2305 | Browser inner width/height: 1024/689 01:57:09 INFO - PROCESS | 2305 | __metrics 01:57:09 INFO - PROCESS | 2305 | 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" 01:57:09 ERROR - PROCESS | 2305 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:57:10 INFO - TEST-INFO | 2305: exit 0 01:57:10 INFO - Browser initialized. 01:57:10 INFO - Running cycle 1/1 for kraken test... 01:57:10 INFO - TEST-INFO | started process 2308 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpowOKic/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:57:22 INFO - PROCESS | 2308 | RSS: Main: 161533952 01:57:22 INFO - PROCESS | 2308 | 01:57:24 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53356/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53356/tests/kraken/driver.html?testName=audio-beat-detection) 01:57:25 INFO - PROCESS | 2308 | RSS: Main: 223719424 01:57:25 INFO - PROCESS | 2308 | 01:57:28 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53356/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53356/tests/kraken/driver.html?testName=audio-dft) 01:57:28 INFO - PROCESS | 2308 | RSS: Main: 238907392 01:57:28 INFO - PROCESS | 2308 | 01:57:31 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53356/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53356/tests/kraken/driver.html?testName=audio-fft) 01:57:32 INFO - PROCESS | 2308 | RSS: Main: 325619712 01:57:32 INFO - PROCESS | 2308 | 01:57:34 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53356/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53356/tests/kraken/driver.html?testName=audio-oscillator) 01:57:35 INFO - PROCESS | 2308 | RSS: Main: 230690816 01:57:35 INFO - PROCESS | 2308 | 01:57:37 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53356/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53356/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:57:38 INFO - PROCESS | 2308 | RSS: Main: 231542784 01:57:38 INFO - PROCESS | 2308 | 01:57:40 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53356/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53356/tests/kraken/driver.html?testName=imaging-darkroom) 01:57:41 INFO - PROCESS | 2308 | RSS: Main: 268353536 01:57:41 INFO - PROCESS | 2308 | 01:57:44 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53356/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53356/tests/kraken/driver.html?testName=imaging-desaturate) 01:57:44 INFO - PROCESS | 2308 | RSS: Main: 269201408 01:57:44 INFO - PROCESS | 2308 | 01:57:47 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53356/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53356/tests/kraken/driver.html?testName=json-parse-financial) 01:57:48 INFO - PROCESS | 2308 | RSS: Main: 269017088 01:57:48 INFO - PROCESS | 2308 | 01:57:49 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53356/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53356/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:57:50 INFO - PROCESS | 2308 | RSS: Main: 260255744 01:57:50 INFO - PROCESS | 2308 | 01:57:52 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53356/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53356/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:57:52 INFO - PROCESS | 2308 | RSS: Main: 266760192 01:57:52 INFO - PROCESS | 2308 | 01:57:54 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53356/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53356/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:57:55 INFO - PROCESS | 2308 | RSS: Main: 270782464 01:57:55 INFO - PROCESS | 2308 | 01:57:58 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53356/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:57:58 INFO - PROCESS | 2308 | RSS: Main: 277667840 01:57:58 INFO - PROCESS | 2308 | 01:58:01 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:58:02 INFO - PROCESS | 2308 | RSS: Main: 274833408 01:58:02 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53356/tests/kraken/driver.html?testName=ai-astar) 01:58:04 INFO - PROCESS | 2308 | RSS: Main: 335921152 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | __start_tp_report 01:58:04 INFO - PROCESS | 2308 | _x_x_mozilla_page_load 01:58:04 INFO - PROCESS | 2308 | _x_x_mozilla_page_load_details 01:58:04 INFO - PROCESS | 2308 | |i|pagename|runs| 01:58:04 INFO - PROCESS | 2308 | |0;ai-astar;110;112;119;113;112;113;114;113;113;134 01:58:04 INFO - PROCESS | 2308 | |1;audio-beat-detection;159;119;143;165;118;143;139;119;171;120 01:58:04 INFO - PROCESS | 2308 | |2;audio-dft;185;188;185;184;186;186;185;184;183;183 01:58:04 INFO - PROCESS | 2308 | |3;audio-fft;70;82;75;158;57;55;56;66;133;55 01:58:04 INFO - PROCESS | 2308 | |4;audio-oscillator;92;91;143;77;86;85;128;80;104;158 01:58:04 INFO - PROCESS | 2308 | |5;imaging-gaussian-blur;89;86;89;86;88;86;90;87;89;85 01:58:04 INFO - PROCESS | 2308 | |6;imaging-darkroom;93;128;143;115;94;94;93;94;94;94 01:58:04 INFO - PROCESS | 2308 | |7;imaging-desaturate;83;84;85;83;86;85;85;83;83;85 01:58:04 INFO - PROCESS | 2308 | |8;json-parse-financial;61;62;62;62;62;61;62;78;57;56 01:58:04 INFO - PROCESS | 2308 | |9;json-stringify-tinderbox;60;62;67;73;74;69;66;66;66;66 01:58:04 INFO - PROCESS | 2308 | |10;stanford-crypto-aes;80;82;80;80;78;79;79;77;94;108 01:58:04 INFO - PROCESS | 2308 | |11;stanford-crypto-ccm;128;128;125;131;140;146;122;125;145;130 01:58:04 INFO - PROCESS | 2308 | |12;stanford-crypto-pbkdf2;172;161;163;162;166;161;162;162;164;215 01:58:04 INFO - PROCESS | 2308 | |13;stanford-crypto-sha256-iterative;67;68;67;68;67;67;66;69;66;68 01:58:04 INFO - PROCESS | 2308 | __end_tp_report 01:58:04 INFO - PROCESS | 2308 | __start_cc_report 01:58:04 INFO - PROCESS | 2308 | _x_x_mozilla_cycle_collect,1893 01:58:04 INFO - PROCESS | 2308 | __end_cc_report 01:58:04 INFO - PROCESS | 2308 | __startTimestamp1465289884342__endTimestamp 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | ------- Summary: start ------- 01:58:04 INFO - PROCESS | 2308 | Number of tests: 14 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | [#0] ai-astar Cycles:10 Average:115.30 Median:113.00 stddev:6.96 (6.2%) stddev-sans-first:7.11 01:58:04 INFO - PROCESS | 2308 | Values: 110.0 112.0 119.0 113.0 112.0 113.0 114.0 113.0 113.0 134.0 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:143.00 stddev:20.36 (14.2%) stddev-sans-first:20.35 01:58:04 INFO - PROCESS | 2308 | Values: 159.0 119.0 143.0 165.0 118.0 143.0 139.0 119.0 171.0 120.0 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.00 stddev:1.52 (0.8%) stddev-sans-first:1.62 01:58:04 INFO - PROCESS | 2308 | Values: 185.0 188.0 185.0 184.0 186.0 186.0 185.0 184.0 183.0 183.0 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | [#3] audio-fft Cycles:10 Average:80.70 Median:61.50 stddev:35.85 (58.3%) stddev-sans-first:37.82 01:58:04 INFO - PROCESS | 2308 | Values: 70.0 82.0 75.0 158.0 57.0 55.0 56.0 66.0 133.0 55.0 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:82.50 stddev:28.51 (34.6%) stddev-sans-first:29.88 01:58:04 INFO - PROCESS | 2308 | Values: 92.0 91.0 143.0 77.0 86.0 85.0 128.0 80.0 104.0 158.0 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.50 stddev:1.72 (1.9%) stddev-sans-first:1.73 01:58:04 INFO - PROCESS | 2308 | Values: 89.0 86.0 89.0 86.0 88.0 86.0 90.0 87.0 89.0 85.0 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | [#6] imaging-darkroom Cycles:10 Average:104.20 Median:94.00 stddev:18.13 (19.3%) stddev-sans-first:18.78 01:58:04 INFO - PROCESS | 2308 | Values: 93.0 128.0 143.0 115.0 94.0 94.0 93.0 94.0 94.0 94.0 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:85.00 stddev:1.14 (1.3%) stddev-sans-first:1.12 01:58:04 INFO - PROCESS | 2308 | Values: 83.0 84.0 85.0 83.0 86.0 85.0 85.0 83.0 83.0 85.0 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:62.00 stddev:5.95 (9.6%) stddev-sans-first:6.29 01:58:04 INFO - PROCESS | 2308 | Values: 61.0 62.0 62.0 62.0 62.0 61.0 62.0 78.0 57.0 56.0 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:66.50 stddev:4.31 (6.5%) stddev-sans-first:3.77 01:58:04 INFO - PROCESS | 2308 | Values: 60.0 62.0 67.0 73.0 74.0 69.0 66.0 66.0 66.0 66.0 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:80.00 stddev:9.79 (12.2%) stddev-sans-first:10.29 01:58:04 INFO - PROCESS | 2308 | Values: 80.0 82.0 80.0 80.0 78.0 79.0 79.0 77.0 94.0 108.0 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:130.50 stddev:8.59 (6.6%) stddev-sans-first:8.99 01:58:04 INFO - PROCESS | 2308 | Values: 128.0 128.0 125.0 131.0 140.0 146.0 122.0 125.0 145.0 130.0 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:163.50 stddev:16.57 (10.1%) stddev-sans-first:17.53 01:58:04 INFO - PROCESS | 2308 | Values: 172.0 161.0 163.0 162.0 166.0 161.0 162.0 162.0 164.0 215.0 01:58:04 INFO - PROCESS | 2308 | 01:58:04 INFO - PROCESS | 2308 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 01:58:04 INFO - PROCESS | 2308 | Values: 67.0 68.0 67.0 68.0 67.0 67.0 66.0 69.0 66.0 68.0 01:58:04 INFO - PROCESS | 2308 | -------- Summary: end -------- 01:58:04 INFO - PROCESS | 2308 | 01:58:05 INFO - TEST-INFO | 2308: exit 0 01:58:05 INFO - TEST-OK | kraken | took 57926ms 01:58:05 INFO - SUITE-END | took 1171s 01:58:05 INFO - Completed test suite (00:19:31) 01:58:05 INFO - javascript benchmark 01:58:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3499.42259527178, 3544.8582056717732, 3565.910852228694, 3578.2127931855, 3627.564692236932, 5923.962858167615, 5934.910976335353, 5944.494717948979, 5945.16767652529, 5997.4902133318665, 5916.88166236675, 5984.431479009498, 5991.071383935486, 6000.309964354101, 6010.939890601093, 5222.451642577513, 5345.1447768357075, 5355.518003379695, 5374.381946076212, 5428.4300148484435, 5351.7324133793345, 5400.810971615994, 5405.135178371462, 5405.621606487528, 5409.864753381157, 5308.761105750251, 5379.462053794608, 5393.757280922348, 5397.811076612319, 5410.1073322901675, 5381.1121165007535, 5410.3507579090365, 5443.374011988632, 5443.646162999393, 5467.58993075517, 5120.61595380348, 5253.08071087562, 5319.5744340452675, 5320.388155362106, 5343.145096784496, 5697.886042279172, 5755.223044888929, 5770.105633626795, 5795.072788353843, 5796.1595568642315, 6222.097795819626, 6254.093156492283, 6254.74981000764, 6274.278457977345, 6275.843103922392, 6135.140800782634, 6245.156903817971, 6296.716647750863, 6302.401271879165, 6305.085762564402, 6056.454919057262, 6060.666663333471, 6073.574849760563, 6089.117078023662, 6103.633781973096, 6369.8726025480155, 6370.968145159244, 6380.489560835122, 6382.266039405527, 6398.200224971879, 6131.14164017038, 6230.190075290183, 6282.4974002079725, 6307.779227727007, 6319.33646967071, 6278.372162783685, 6296.748130074746, 6297.4962003039645, 6297.937020629735, 6305.148804911279, 6192.102145188923, 6267.091271765568, 6275.560710750295, 6285.717142728588, 6288.748450062038, 6208.441240288305, 6224.346443623354, 6259.374062593704, 6271.9686401568615, 6318.273398559132, 5004.249362595567, 5034.194528875362, 5040.84877453677, 5045.0, 5065.062963351792, 4543.568361005699, 4544.272916333371, 4555.202839503074, 4577.29051996941, 4598.977005114953, 5860.179574859523, 5946.851328716817, 5995.880082398327, 6063.242094738158, 6092.3603021682975, 6191.230006342012, 6238.532110091761, 6250.718717657625, 6258.217722784652, 6286.371362863677, 6028.125921741323, 6043.909341359883, 6051.425114614105, 6052.978485263027, 6068.33248342682, 5398.6220964532895, 5465.07093794056, 5473.67157970523, 5522.585806064561, 5535.197396377503, 6428.453581445442, 6478.546501744832, 6522.673866306761, 6523.510736694767, 6530.608163510205, 5510.641808282448, 6193.040078787795, 6262.624242545462, 6263.467605253604, 6270.404311590391, 6418.646974416265, 6479.676016199077, 6498.122753428227, 6501.934980650133, 6517.576357536745, 6230.657313847782, 6249.96875015622, 6257.56197066201, 6267.62394256346, 6278.686065696788, 5710.114932185518, 5811.651300921789, 6262.15460912771, 6263.154474145932, 6268.655223962726, 6168.660723660242, 6262.68686565679, 6263.0, 6265.404786545271, 6276.089966954857, 6264.404881536247, 6265.843353916189, 6275.121482992294, 6282.497400207881, 6286.591371560834, 5984.790532331347, 6007.219061521974, 6104.725287361991, 6155.1382806406245, 6203.720832562455, 6107.994843641952, 6133.824358647991, 6241.625502469867, 6265.937340626535, 6275.5920865145445, 6159.599626024294, 6162.352952939877, 6207.0, 6209.316975132822, 6214.25428948529], "value": 5837.987130095888, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.9460720469867, 604.2688347100008, 683.0232767142984, 689.3485656055027, 689.8103021669043, 32432.675673243262, 39890.8005459973, 40176.0, 40194.59805401945, 40469.988250293754, 46213.0, 46690.29964550534, 46732.06535869281, 46812.0, 46881.531184688145, 9110.0, 10016.849747253797, 10176.898231017669, 10191.643292484765, 10193.1845452364, 11902.702432439215, 12210.694732631666, 12229.694257643541, 12251.816222756666, 12253.448594813255, 12057.457414416329, 12149.392530373447, 12149.574764883231, 12157.51369945201, 12178.756424871497, 9299.0, 12029.51881924722, 12129.575464858732, 12195.878041219607, 12346.5061397544, 11853.525858965631, 11984.880151198464, 11988.580399685969, 11994.100442466763, 12006.339651319175, 39365.80317098425, 39704.404433933516, 39730.0, 39822.40266396006, 39842.20315593672, 3477.443609022544, 3635.94546081809, 3767.303048935928, 3888.591697871711, 3920.5295364556437, 28311.433771324664, 28951.697173627028, 28999.565006524917, 29032.709672903213, 29636.85181574078, 2798.524250877356, 2849.301921029361, 2899.492588796952, 2917.6498820141505, 3015.803972741765, 457587.0, 459028.0, 461456.0, 462240.6887965539, 462650.0, 65669.0, 65799.67100164469, 65836.34163658398, 65900.34099658942, 65977.67011164913, 69526.0, 69713.0, 69813.0, 69980.0, 69993.65003175053, 16999.0, 18893.811061889206, 19122.426327210207, 19152.61694766097, 19231.230750770093, 12966.0, 14499.202543859978, 14628.268586570628, 14863.108213507225, 14870.0, 14466.927665361816, 17522.0, 17553.648927021644, 17695.203715832817, 17744.846584971936, 7183.856322873513, 7295.088113985752, 7324.011258480037, 7325.447158128303, 7392.519486233377, 931.2317338196016, 1053.836655318427, 1056.8361903904906, 1069.5240617924949, 1102.1678632632472, 24322.0, 30956.845215773777, 31345.686543134732, 31380.529292060637, 33064.173395665304, 1008.5965613754557, 1182.6984119049587, 1189.9107566932514, 1202.374765122149, 1219.4329636718792, 13226.73546529064, 14428.927855360656, 15708.764368534481, 15721.606959826096, 16070.196490175444, 611591.0, 616340.0, 618312.0, 621025.0, 622350.0, 64741.67629161918, 65013.02480462797, 65056.0, 65059.04822855322, 65313.0, 1455.6870272891379, 1499.5276487906492, 1581.7311057120316, 1582.5806161367016, 1584.7543630737255, 30225.52664188352, 31603.0, 31891.840540797148, 32324.0, 33036.33927321488, 56650.43349566452, 57096.85806283768, 57778.133327999276, 57797.71101144636, 57818.0, 519871.0, 533525.0, 535830.0, 536594.0, 537047.0, 37147.25705485929, 40220.0, 45489.77255113703, 46384.0, 46580.0, 47079.0, 47120.0, 47730.522694772604, 48196.0, 48848.51151488582, 38603.420948686355, 40866.38700419437, 41272.1745565093, 41440.0, 41792.3731144027, 39737.0, 39841.40237896376, 40144.79927600343, 40169.1966160681, 40915.7954210227, 40050.79974600108, 40406.0, 40675.59324406718, 40933.59066409417, 41501.58498415098, 32526.02421927346, 33961.39636959874, 33999.83000084984, 34079.97760067202, 34518.48222276718, 25850.35374115662, 25924.870375648003, 26015.479690405708, 26265.0, 26308.21075367742], "value": 21434.98291236322, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.0715372603409, 421.3658444041717, 422.11988005009533, 424.3931178414866, 433.2180414352095, 21393.82333971631, 21762.911854407277, 22035.33893983181, 22376.881155942177, 22874.77125228747, 21622.89188554059, 21874.453138671543, 22228.333150005485, 22492.550148997012, 22523.211687590938, 6071.817845464643, 6260.280067792194, 6272.404121608462, 6283.994560870262, 6288.182536270278, 4569.337446070318, 4809.326694262789, 6214.5649804513705, 6296.181496405461, 6999.860002799941, 6658.966705166467, 6886.793396198122, 6894.413974812147, 6921.619310937896, 6946.6179360135175, 5300.761465734032, 6327.620342779402, 6335.447815285284, 6891.379775820175, 6911.067005954207, 4165.562615925314, 5940.34656187819, 6177.567570270083, 6187.226596675416, 6207.131001659771, 13927.512537061255, 14119.294035298193, 14168.787468187986, 14174.362153703109, 26822.792974316006, 2151.537419454825, 2247.741509726386, 2355.3993731598503, 2877.963932984124, 2884.6971068037765, 10363.740906477324, 10416.479176041168, 10839.729006774814, 11979.0, 15902.363905443768, 1866.4120801947342, 1870.6165236126562, 1909.8376637985648, 1935.6902895536787, 1943.640426521098, 115331.42334288274, 125115.0, 127813.0, 128122.07816882755, 128238.35880820629, 11833.585824496102, 11840.822387664191, 12079.75840483203, 12123.757524849454, 12266.386680665932, 15764.211789410483, 15781.842181578037, 15807.683846323009, 15829.841701582836, 15843.603909902346, 9005.099490050943, 9265.490398028038, 9334.113259240361, 9434.433933963985, 9455.952720236355, 8866.778330541789, 9383.483908385104, 9416.387934784218, 9423.34036617444, 9487.335886488017, 3818.59904710007, 4835.782389792468, 4906.11689895815, 4910.803567857317, 4957.801687932514, 2018.2128969701828, 2040.877547347164, 2056.619525387808, 2063.8658487198286, 2073.154892145991, 896.8923729152413, 902.7968707040864, 937.4281688170211, 950.7860731335533, 989.2549859244315, 21240.389133847282, 21910.89044554767, 22007.449813754785, 22311.4341850686, 22336.66495002544, 1046.2676126711333, 1047.1308813684775, 1054.1830081686753, 1065.1053115383115, 1128.328644456547, 10015.748031496063, 11223.887761122447, 11540.422978851024, 11611.187216894736, 11714.76570468603, 544650.2767486137, 630587.0, 637497.0, 650878.0, 671225.0, 77376.0, 78059.60970195226, 100901.0, 134293.0, 145250.0, 914.963401463934, 921.2445794448622, 934.4066517761271, 945.3713280668278, 948.5304774136846, 18637.44087677372, 19083.522911926757, 19259.422217333504, 19278.421647350602, 19443.519572228295, 53098.93802123859, 53396.93206135933, 53623.731881341904, 54052.0, 54550.727246363516, 73466.0, 75240.06815799428, 75439.24560754323, 78147.218527814, 78221.0, 8454.0, 8496.06543280251, 8509.957450212709, 8706.216440520384, 8775.210231079234, 9604.51977401141, 12654.43055062506, 13436.798448023092, 13457.0, 14026.649333766738, 11711.063114950613, 11815.822762658396, 11840.28958262507, 11887.702807429883, 12165.513379465076, 11556.422178890854, 11740.647780566596, 11769.234999724991, 12010.33943133136, 12037.699057523632, 11887.227330223508, 11971.760564788481, 12082.75834483323, 12165.817512737493, 12183.390830458618, 8580.270676992526, 8647.203475641094, 8683.478991260545, 8740.737777866674, 8874.511901845202, 8622.870656940026, 10983.450827458755, 11918.344491052729, 12036.0, 12132.514699412277], "value": 9922.908079460945, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.0744830756635, 1623.1965177237266, 1653.099061011748, 1933.9806601933985, 2033.4306394209627, 8231.259186673198, 8844.15980481854, 8948.328875334344, 8967.641294348234, 8970.416922900024, 8627.611757470913, 8861.955690221555, 8890.0, 8901.332400070005, 8904.643814247422, 2549.0058877037923, 2576.6779152605923, 2577.1495406515805, 2577.793776497885, 2579.1617724239604, 2498.3379404457833, 2562.6796650418696, 2564.8974041038337, 2567.922962311124, 2573.318070711263, 2529.4941011797623, 2555.1823416506727, 2571.961420578693, 2576.021111977446, 2585.9482810343784, 2332.682034650417, 2349.7297810751725, 2524.066095544642, 2567.679040119985, 2572.254046326563, 2520.7227205007434, 2559.5264875998, 2561.820672552922, 2564.743525647439, 2576.780973617245, 8828.426152300144, 9036.728898133066, 9117.908820911773, 9123.224525915306, 9125.589348479269, 5592.692401917933, 5758.971205143947, 5813.767449302023, 5837.941620583782, 5848.88302233953, 3581.4090675038588, 3602.9279414411567, 3640.7633503822167, 3721.776693398405, 3792.9620703792884, 964.9614015439374, 1041.7760181561, 1055.1242468750918, 1055.7278479432266, 1103.0458653264868, 11471.48378322969, 11563.074954003743, 11756.235844670155, 11793.410329483491, 11795.351255680935, 4688.2733176357715, 4705.576498115186, 4715.882102947454, 4778.737169455644, 4788.545088216614, 9414.529273536296, 9424.246060315158, 9435.622575097057, 9438.292128090421, 9461.621535138655, 5536.916946245809, 5537.086380747131, 5538.667679939216, 5538.975289571362, 5553.278073850373, 4636.281376386665, 4792.9281060784115, 4998.125328067574, 5162.716050617177, 5167.689938603696, 3271.9018429447156, 4013.3177359848896, 4061.431399604058, 4101.733387329814, 4144.958550414518, 1085.3921803789904, 1227.8642255913244, 1235.734317121823, 1252.2423933520272, 1256.8051951947464, 956.4978386347224, 980.8626792249091, 995.6117114325419, 1003.6136087606324, 1017.3285631483186, 6106.877862442726, 6164.044573091178, 6186.721597528122, 6233.158523599347, 6235.407636274546, 462.0873774295806, 479.8344571122957, 480.5434836904954, 494.32277779441677, 495.68523987268344, 4035.152617950205, 4092.508898932147, 4107.97946010274, 4130.0, 4140.358244472111, 10549.367037977592, 10885.401302928256, 10980.176486763525, 10983.340999540053, 10987.560497580007, 10699.14406847466, 10794.838077428845, 10832.295900766425, 10849.728756781144, 10862.293950893167, 8404.747857564284, 8476.152384761597, 8482.703105391281, 8493.447925884675, 8508.234258916727, 5734.885302293847, 5829.271341082364, 5836.0, 5971.701414929149, 6049.455549000611, 9638.469884156159, 9708.368956017835, 9709.6601618943, 9782.608695652094, 9811.656592019244, 9462.716118516455, 9885.406875587487, 9956.452395118338, 9977.0, 9981.550830212513, 6657.500687448558, 6786.830329241809, 7058.3647471725735, 7144.64276786169, 7232.312930271616, 8486.74539763808, 8501.532415716947, 8560.229579337889, 8575.699850505202, 8599.52702601363, 7478.177400486051, 7619.276168763959, 7635.88546171819, 7700.075990881131, 7718.421118416029, 7186.425085993003, 7244.166920804175, 7276.8908466374105, 7374.594397307985, 7378.778636640909, 7209.819754506179, 7267.563946163035, 7307.525010874276, 7309.269073092648, 7328.3404493595835, 4991.126552853309, 5015.448300686849, 5088.669236499616, 5128.58971282304, 5196.142636464941, 4939.431965324034, 5044.772985215601, 5123.3339665843205, 5160.48395160481, 5395.81114660985], "value": 4619.610189098547, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.0983529716819, 335.08521735661645, 340.87001589730045, 342.80288833920486, 345.43176474699106, 6787.389134977851, 6838.0768596239495, 6845.760398386051, 6870.38166565009, 6896.689648965796, 6785.1179346684985, 6789.321067893221, 6807.829804254896, 6829.6926638301275, 6834.453243740501, 4813.831515896944, 4908.926366104493, 4914.655974081816, 4992.87517812054, 5053.418856831457, 4967.279744437054, 5024.447310795809, 5030.773615187307, 5032.4967503249745, 5032.9748351258195, 4973.701577905319, 4983.700977941335, 4989.825356112537, 4993.950060499385, 5071.797128114871, 4793.760311984404, 4847.951520484785, 4960.23116416956, 4966.627502937258, 4980.477049909779, 4278.657707383433, 4287.506936702257, 4291.120320334324, 4291.849785257501, 4304.548022457629, 6490.253620833618, 6543.770968016144, 6599.274079851212, 6601.966990165019, 6607.80176594703, 5936.1095835625, 5937.960856850034, 5941.405859414067, 5942.138389933479, 5945.375735547748, 6637.800865974028, 6668.833279168011, 7248.963755181243, 7254.129504459499, 7259.818504537376, 4660.277656963176, 4670.509596492353, 4683.695559788603, 4691.976540117277, 4698.013417182396, 7536.321731044178, 7654.693812247503, 7659.080910290745, 7673.808154796119, 7678.462507624468, 4743.549362810528, 4743.905121897612, 4746.264329029006, 4751.64362672801, 4758.333833263277, 4803.495632958489, 4805.519448055236, 4817.8313759018265, 4826.32431459596, 4827.468978412442, 4726.243800991825, 5583.0787919992745, 5791.594588378857, 5805.7387417566315, 5817.360090390053, 7274.527155734861, 7290.0, 7291.598962057032, 7306.232845551247, 7320.975063491115, 1623.2614160556918, 1663.8502534771928, 1664.7419649954277, 1665.5919299771633, 1673.6820004199162, 879.6745204274331, 1036.9118624916816, 1064.6380230721593, 1066.8559744434558, 1069.417167643636, 6645.202575690948, 6787.0, 6831.795046148623, 6840.076589660432, 6921.0, 7535.698572057166, 7556.395488360918, 7560.773176804704, 7568.978187944557, 7589.051368578927, 6882.414994725505, 6894.069300644449, 6904.4821638377325, 6910.689018994158, 6917.965410172917, 3218.3563287342627, 4007.5992400760274, 4012.25773231953, 4013.3779264214095, 4021.235965166609, 7624.42816788743, 7888.566128862853, 7894.447388682737, 7906.7627971160955, 7928.841423171504, 7805.609719514002, 7810.804729881685, 7816.4757872215505, 7826.608669566499, 7851.607419628996, 7904.6838126474295, 7908.683652653829, 7915.841683166304, 7923.128455869965, 7929.1277959424415, 7275.126984761862, 7494.175640679412, 7527.247275272429, 7534.35957943559, 7556.8866467001935, 7390.29792169743, 7448.478606497493, 7465.589392583242, 7468.813279668052, 7471.663775130023, 7290.270972902667, 7766.417518686008, 7882.921170788448, 7895.447318687637, 7906.0, 4758.214894542501, 4776.713397196179, 4777.784999675093, 4779.402574678165, 4784.306275590089, 7297.343239108506, 7538.547687138789, 7557.470977031775, 7571.091469023752, 7573.545587264782, 7272.89090663651, 7290.234525374759, 7294.635268236673, 7305.707771689285, 7326.0, 5891.94108058931, 7303.963480182565, 7317.524360916736, 7319.34125928669, 7322.121345438369, 5886.941130588811, 7070.68181931804, 7147.499675022698, 7164.820879478055, 7181.461390395846, 6348.587341822767, 7038.824029399306, 7304.0, 7336.449766267445, 7356.227596102546, 6859.07402500676, 6960.825979350354, 7035.542689725152, 7089.432845372461, 7219.061522002106], "value": 5295.965050761432, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.7547895975888, 736.5948728199489, 781.6912319633744, 797.4776521378495, 797.892284541587, 15439.382424703012, 15622.375104995815, 15669.059856408623, 15678.372865085397, 15680.686386272268, 14293.213873236968, 14488.782668259984, 14510.854891451083, 14517.20155391453, 14517.564473065824, 786.6813940354151, 808.1756608259572, 963.9903600964005, 995.4176806568166, 995.8954309797475, 963.9855402168973, 975.0054943957159, 976.3019441099613, 976.990230097697, 977.5258999385293, 824.5382585751968, 1042.1506472225112, 1044.968650940473, 1047.0419566097012, 1047.6752206815872, 826.5371392020458, 833.1002517281352, 837.2924878477677, 1008.6873069348526, 1041.8697662792151, 780.157429975625, 782.0927723840375, 782.3662833105203, 783.2363445640511, 783.9333656639193, 15407.383704651913, 15459.61350966235, 15470.845291547053, 15480.5355839325, 15540.378384864593, 12889.806652900214, 12985.740285194242, 13204.0, 13269.270190139538, 13562.864371356358, 10211.285210035301, 10263.46229267299, 10442.843357349646, 10646.680599582025, 11052.613158539412, 3554.3424466473784, 3566.9108272293142, 3595.7123430125525, 3631.382664946965, 3704.351738445788, 86171.5691421539, 86664.0, 88983.0, 89372.10627893703, 89864.55067724685, 9773.21814254858, 9855.26085543587, 9886.011398860057, 9928.453935033642, 9976.950115249523, 23067.307980760605, 23874.806259686946, 24078.39804004914, 24101.03595856146, 24109.794510274765, 7804.180561041123, 7839.6472158752995, 7952.0, 7958.403119766041, 8214.26071653554, 3985.362342025262, 4089.9795501022304, 4251.3622956556765, 4313.525512193656, 4374.212641724456, 3822.0, 3880.7477513961503, 3883.0874744435037, 3883.37865941448, 3896.551896531935, 608.558794873713, 699.8845190543606, 708.0830324729487, 714.8348192446383, 720.5748608321115, 522.811787756415, 536.6940843719043, 578.320473443702, 592.6473748119862, 598.3537779198455, 8117.391195660349, 8551.486910785372, 8769.342299327576, 9035.36752427337, 9160.6793762218, 625.3308959413384, 636.5671343486381, 644.0628884972353, 646.2955378637308, 648.8896887529131, 3824.388097904322, 3976.522817261889, 4040.4545386372465, 4067.613576710208, 4251.383549385384, 82881.3423731522, 90395.09604903999, 92362.0, 92708.53645731728, 92763.60854587186, 71928.20179495554, 73015.63492182505, 76047.0, 78340.60829695815, 78398.6080069596, 64948.67525662341, 65998.6800263992, 66936.66531667311, 67082.0, 70034.64982674952, 8420.873686894824, 8698.130186981505, 8710.869336960077, 8836.690715824916, 8940.061293564342, 43806.0, 44684.659460216244, 44691.0, 44949.32576011297, 45615.0, 64531.677341612994, 65331.346686532524, 65963.0, 67903.0, 68149.65925170343, 11674.182807203415, 11927.940360298144, 12041.518339266331, 12086.758264834478, 12154.817677734663, 10081.344712593658, 11597.594084207012, 12196.756064878475, 12225.327606981702, 12308.753824923631, 11504.086625543763, 11780.057595392176, 12157.148999569945, 12361.690957726129, 12411.875881241072, 11625.865019718864, 12176.964957978671, 12201.755964880474, 12205.962493187822, 12306.323152226714, 11394.715132121763, 12002.0, 12235.143539952118, 12362.690932726753, 12379.814302785646, 8807.955960220157, 10007.299489035697, 10210.030047145508, 10216.540255688364, 10355.43045132525, 8961.820763584561, 9508.477033763209, 9539.332246742939, 9972.700818975442, 9973.202143828332], "value": 7146.960698476927, "unit": "score"}], "name": "dromaeo_css", "value": 7752.754412835995, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 119.0, 113.0, 112.0, 113.0, 114.0, 113.0, 113.0, 134.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 119.0, 143.0, 165.0, 118.0, 143.0, 139.0, 119.0, 171.0, 120.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 188.0, 185.0, 184.0, 186.0, 186.0, 185.0, 184.0, 183.0, 183.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 82.0, 75.0, 158.0, 57.0, 55.0, 56.0, 66.0, 133.0, 55.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 143.0, 77.0, 86.0, 85.0, 128.0, 80.0, 104.0, 158.0], "value": 104.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 86.0, 88.0, 86.0, 90.0, 87.0, 89.0, 85.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 128.0, 143.0, 115.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0], "value": 104.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 85.0, 83.0, 86.0, 85.0, 85.0, 83.0, 83.0, 85.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 78.0, 57.0, 56.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 67.0, 73.0, 74.0, 69.0, 66.0, 66.0, 66.0, 66.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 80.0, 80.0, 78.0, 79.0, 79.0, 77.0, 94.0, 108.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 125.0, 131.0, 140.0, 146.0, 122.0, 125.0, 145.0, 130.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 161.0, 163.0, 162.0, 166.0, 161.0, 162.0, 162.0, 164.0, 215.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 66.0, 69.0, 66.0, 68.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1481.8, "alertThreshold": 2.0}]} 01:58:05 INFO - Return code: 0 01:58:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:58:05 ERROR - # TBPL SUCCESS # 01:58:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:58:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:58:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:58:05 INFO - 2016-06-07 01:58:05.666 screenresolution[2312:21907] starting screenresolution argv=screenresolution get 01:58:05 INFO - 2016-06-07 01:58:05.668 screenresolution[2312:21907] Display 0: 1600x1200x32@60 01:58:05 INFO - 2016-06-07 01:58:05.674 screenresolution[2313:21910] starting screenresolution argv=screenresolution list 01:58:05 INFO - Available Modes on Display 0 01:58:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:58:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:58:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:58:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:58:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:58:05 INFO - Intel Iris: 01:58:05 INFO - Chipset Model: Intel Iris 01:58:05 INFO - Type: GPU 01:58:05 INFO - Bus: Built-In 01:58:05 INFO - VRAM (Dynamic, Max): 1536 MB 01:58:05 INFO - Vendor: Intel (0x8086) 01:58:05 INFO - Device ID: 0x0a2e 01:58:05 INFO - Revision ID: 0x0009 01:58:05 INFO - Displays: 01:58:05 INFO - Display: 01:58:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:58:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:58:05 INFO - Display Serial Number: 1600x1200 60 01:58:05 INFO - Main Display: Yes 01:58:05 INFO - Mirror: Off 01:58:05 INFO - Online: Yes 01:58:05 INFO - Rotation: Supported 01:58:05 INFO - Return code: 0 01:58:05 INFO - Running post-action listener: _resource_record_post_action 01:58:05 INFO - Running post-run listener: _resource_record_post_run 01:58:06 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 282624; Write bytes: 490700800; Read time: 4; Write time: 1622 01:58:06 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 188948992; Write bytes: 185779712; Read time: 17630; Write time: 490 01:58:06 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 282624; Write bytes: 294087168; Read time: 4; Write time: 1100 01:58:06 INFO - Running post-run listener: _upload_blobber_files 01:58:06 INFO - Blob upload gear active. 01:58:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:58:06 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 01:58:06 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'] 01:58:06 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 01:58:07 INFO - (blobuploader) - INFO - Open directory for files ... 01:58:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:58:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:58:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:08 INFO - (blobuploader) - INFO - Done attempting. 01:58:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:58:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:58:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:10 INFO - (blobuploader) - INFO - Done attempting. 01:58:10 INFO - (blobuploader) - INFO - Iteration through files over. 01:58:10 INFO - Return code: 0 01:58:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:58:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:58:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f5bcd1f211fda7094a6fbb94cede19b829915e72be9d789ff3427b17b26d55e838cfdfa3c2da669f879d0260d0238cf25f8e313bd5bbac8d891aaa2f2be9bff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a642b0f75bf93db95515bf100a3371c9399242bc628f2b12cebc03b21758872a681d8d31960246c2906c1ff2b30476c2628b18b26f06b44f1bdaef0c30b2f9c"} 01:58:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:58:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:58:10 INFO - Contents: 01:58:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f5bcd1f211fda7094a6fbb94cede19b829915e72be9d789ff3427b17b26d55e838cfdfa3c2da669f879d0260d0238cf25f8e313bd5bbac8d891aaa2f2be9bff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a642b0f75bf93db95515bf100a3371c9399242bc628f2b12cebc03b21758872a681d8d31960246c2906c1ff2b30476c2628b18b26f06b44f1bdaef0c30b2f9c"} 01:58:10 INFO - Running post-run listener: copy_logs_to_upload_dir 01:58:10 INFO - Copying logs to upload dir... 01:58:10 INFO - mkdir: /builds/slave/test/build/upload/logs 01:58:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.895466 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-07 01:58:10.775210) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:10.779310) ========= 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.YqMqFTMSco/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.58ZqAw1Jdk/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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/9f5bcd1f211fda7094a6fbb94cede19b829915e72be9d789ff3427b17b26d55e838cfdfa3c2da669f879d0260d0238cf25f8e313bd5bbac8d891aaa2f2be9bff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a642b0f75bf93db95515bf100a3371c9399242bc628f2b12cebc03b21758872a681d8d31960246c2906c1ff2b30476c2628b18b26f06b44f1bdaef0c30b2f9c"} build_url:https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f5bcd1f211fda7094a6fbb94cede19b829915e72be9d789ff3427b17b26d55e838cfdfa3c2da669f879d0260d0238cf25f8e313bd5bbac8d891aaa2f2be9bff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a642b0f75bf93db95515bf100a3371c9399242bc628f2b12cebc03b21758872a681d8d31960246c2906c1ff2b30476c2628b18b26f06b44f1bdaef0c30b2f9c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:10.813347) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:10.813825) ========= 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.YqMqFTMSco/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.58ZqAw1Jdk/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.005266 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:10.863946) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 01:58:10.864301) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 01:58:10.864920) ========= ========= Total master_lag: 0.41 =========