builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0158 starttime: 1464191116.78 results: success (0) buildid: 20160525071041 builduid: 51a06339b3b746c2a12a7a3c6a921a7b revision: b01ee9309ba0d1d2ac65e4f2d8e25899ca817ec4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 08:45:16.776251) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 08:45:16.776744) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 08:45:16.777024) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 08:45:16.800164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 08:45:16.800575) ========= 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.v9KteHxHUi/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.5dxQRdO0l6/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-25 08:45:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-05-25 08:45:16 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 08:45:16.959485) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 08:45:16.959811) ========= 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.v9KteHxHUi/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.5dxQRdO0l6/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.027570 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 08:45:17.009934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 08:45:17.010304) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b01ee9309ba0d1d2ac65e4f2d8e25899ca817ec4 --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-aurora --rev b01ee9309ba0d1d2ac65e4f2d8e25899ca817ec4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v9KteHxHUi/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.5dxQRdO0l6/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-25 08:45:17,136 truncating revision to first 12 chars 2016-05-25 08:45:17,136 Setting DEBUG logging. 2016-05-25 08:45:17,136 attempt 1/10 2016-05-25 08:45:17,136 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b01ee9309ba0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 08:45:17,779 unpacking tar archive at: mozilla-aurora-b01ee9309ba0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.891188 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 08:45:17.921534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 08:45:17.921903) ========= script_repo_revision: b01ee9309ba0d1d2ac65e4f2d8e25899ca817ec4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 08:45:17.922377) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 08:45:17.922694) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 08:45:17.939125) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-25 08:45:17.939587) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v9KteHxHUi/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.5dxQRdO0l6/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 08:45:18 INFO - MultiFileLogger online at 20160525 08:45:18 in /builds/slave/test 08:45:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:45:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:45:18 INFO - {'append_to_log': False, 08:45:18 INFO - 'base_work_dir': '/builds/slave/test', 08:45:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:45:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:45:18 INFO - 'branch': 'Mozilla-Aurora', 08:45:18 INFO - 'buildbot_json_path': 'buildprops.json', 08:45:18 INFO - 'config_files': ('talos/mac_config.py',), 08:45:18 INFO - 'default_actions': ('clobber', 08:45:18 INFO - 'read-buildbot-config', 08:45:18 INFO - 'download-and-extract', 08:45:18 INFO - 'populate-webroot', 08:45:18 INFO - 'create-virtualenv', 08:45:18 INFO - 'install', 08:45:18 INFO - 'run-tests'), 08:45:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:45:18 INFO - 'download_minidump_stackwalk': True, 08:45:18 INFO - 'download_symbols': 'ondemand', 08:45:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:45:18 INFO - 'tooltool.py': '/tools/tooltool.py', 08:45:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:45:18 INFO - '/tools/misc-python/virtualenv.py')}, 08:45:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:45:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:45:18 INFO - 'installer_path': 'installer.exe', 08:45:18 INFO - 'log_level': 'info', 08:45:18 INFO - 'log_name': 'talos', 08:45:18 INFO - 'log_to_console': True, 08:45:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:45:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:45:18 INFO - 'opt_config_files': (), 08:45:18 INFO - 'pip_index': False, 08:45:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:45:18 INFO - 'cmd': ('bash', 08:45:18 INFO - '-c', 08:45:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:45:18 INFO - 'enabled': True, 08:45:18 INFO - 'halt_on_failure': False, 08:45:18 INFO - 'name': 'check_screen_resolution'},), 08:45:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:45:18 INFO - 'cmd': ('bash', 08:45:18 INFO - '-c', 08:45:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:45:18 INFO - 'enabled': True, 08:45:18 INFO - 'halt_on_failure': False, 08:45:18 INFO - 'name': 'check_screen_resolution'},), 08:45:18 INFO - 'run_cmd_checks_enabled': True, 08:45:18 INFO - 'sps_profile': False, 08:45:18 INFO - 'sps_profile_interval': 0, 08:45:18 INFO - 'suite': 'dromaeojs-e10s', 08:45:18 INFO - 'system_bits': '32', 08:45:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:45:18 INFO - 'title': 't-yosemite-r7-0158', 08:45:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:45:18 INFO - 'use_talos_json': True, 08:45:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:45:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:45:18 INFO - 'work_dir': 'build'} 08:45:18 INFO - ##### 08:45:18 INFO - ##### Running clobber step. 08:45:18 INFO - ##### 08:45:18 INFO - Running pre-action listener: _resource_record_pre_action 08:45:18 INFO - Running main action method: clobber 08:45:18 INFO - rmtree: /builds/slave/test/build 08:45:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:45:20 INFO - Running post-action listener: _resource_record_post_action 08:45:20 INFO - ##### 08:45:20 INFO - ##### Running read-buildbot-config step. 08:45:20 INFO - ##### 08:45:20 INFO - Running pre-action listener: _resource_record_pre_action 08:45:20 INFO - Running main action method: read_buildbot_config 08:45:20 INFO - Using buildbot properties: 08:45:20 INFO - { 08:45:20 INFO - "project": "", 08:45:20 INFO - "product": "firefox", 08:45:20 INFO - "script_repo_revision": "production", 08:45:20 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:45:20 INFO - "repository": "", 08:45:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:45:20 INFO - "buildid": "20160525071041", 08:45:20 INFO - "pgo_build": "False", 08:45:20 INFO - "basedir": "/builds/slave/test", 08:45:20 INFO - "buildnumber": 337, 08:45:20 INFO - "slavename": "t-yosemite-r7-0158", 08:45:20 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:45:20 INFO - "platform": "yosemite_r7", 08:45:20 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:45:20 INFO - "branch": "mozilla-aurora", 08:45:20 INFO - "repo_path": "releases/mozilla-aurora", 08:45:20 INFO - "revision": "b01ee9309ba0d1d2ac65e4f2d8e25899ca817ec4", 08:45:20 INFO - "stage_platform": "macosx64", 08:45:20 INFO - "builduid": "51a06339b3b746c2a12a7a3c6a921a7b", 08:45:20 INFO - "slavebuilddir": "test" 08:45:20 INFO - } 08:45:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 08:45:20 INFO - Running post-action listener: _resource_record_post_action 08:45:20 INFO - ##### 08:45:20 INFO - ##### Running download-and-extract step. 08:45:20 INFO - ##### 08:45:20 INFO - Running pre-action listener: _resource_record_pre_action 08:45:20 INFO - Running main action method: download_and_extract 08:45:20 INFO - mkdir: /builds/slave/test/build/tests 08:45:20 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')]} 08:45:20 INFO - https://queue.taskcluster.net/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:45:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 08:45:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 08:45:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 08:45:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 08:45:21 INFO - Downloaded 1199 bytes. 08:45:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 08:45:21 INFO - Using the following test package requirements: 08:45:21 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 08:45:21 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:45:21 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 08:45:21 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:45:21 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 08:45:21 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:45:21 INFO - u'jsshell-mac.zip'], 08:45:21 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:45:21 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 08:45:21 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 08:45:21 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:45:21 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 08:45:21 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:45:21 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 08:45:21 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:45:21 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 08:45:21 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:45:21 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 08:45:21 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:21 INFO - https://queue.taskcluster.net/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:45:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 08:45:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 08:45:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 08:45:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:45:22 INFO - Downloaded 18425374 bytes. 08:45:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:45:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:45:25 INFO - Return code: 0 08:45:25 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:45:25 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')]} 08:45:25 INFO - https://queue.taskcluster.net/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:45:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 08:45:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 08:45:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 08:45:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:45:27 INFO - Downloaded 18425374 bytes. 08:45:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:45:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:45:30 INFO - Return code: 0 08:45: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')]} 08:45:30 INFO - https://queue.taskcluster.net/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:45:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 08:45:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 08:45:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 08:45:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:45:32 INFO - Downloaded 10840145 bytes. 08:45:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:45:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:45:32 INFO - Return code: 0 08:45: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')]} 08:45:32 INFO - https://queue.taskcluster.net/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 08:45:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 08:45:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 08:45:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 08:45:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 08:45:35 INFO - Downloaded 114137951 bytes. 08:45:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 08:45:35 INFO - mkdir: /builds/slave/test/properties 08:45:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:45:35 INFO - Writing to file /builds/slave/test/properties/build_url 08:45:35 INFO - Contents: 08:45:35 INFO - build_url:https://queue.taskcluster.net/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 08:45:36 INFO - Running post-action listener: _resource_record_post_action 08:45:36 INFO - Running post-action listener: set_extra_try_arguments 08:45:36 INFO - ##### 08:45:36 INFO - ##### Running populate-webroot step. 08:45:36 INFO - ##### 08:45:36 INFO - Running pre-action listener: _resource_record_pre_action 08:45:36 INFO - Running main action method: populate_webroot 08:45:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:36 INFO - '--tppagecycles', 08:45:36 INFO - '7'], 08:45:36 INFO - 'tests': ['tsvgm']}}, 08:45:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:45:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:45:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:45:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:45:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:45:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:36 INFO - 'talos_options': ['--disable-e10s'], 08:45:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:36 INFO - 'talos_options': ['--disable-e10s'], 08:45:36 INFO - 'tests': ['damp', 'tps']}, 08:45:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:36 INFO - 'tests': ['damp', 'tps']}, 08:45:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:45:36 INFO - 'tests': ['dromaeo_dom']}, 08:45:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:45:36 INFO - 'tests': ['a11yr', 08:45:36 INFO - 'ts_paint', 08:45:36 INFO - 'tpaint', 08:45:36 INFO - 'sessionrestore', 08:45:36 INFO - 'sessionrestore_no_auto_restore', 08:45:36 INFO - 'tabpaint']}, 08:45:36 INFO - 'other-e10s': {'tests': ['a11yr', 08:45:36 INFO - 'ts_paint', 08:45:36 INFO - 'tpaint', 08:45:36 INFO - 'sessionrestore', 08:45:36 INFO - 'sessionrestore_no_auto_restore', 08:45:36 INFO - 'tabpaint']}, 08:45:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:45:36 INFO - 'ts_paint', 08:45:36 INFO - 'tpaint', 08:45:36 INFO - 'sessionrestore', 08:45:36 INFO - 'sessionrestore_no_auto_restore', 08:45:36 INFO - 'tabpaint']}, 08:45:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:45:36 INFO - 'ts_paint', 08:45:36 INFO - 'tpaint', 08:45:36 INFO - 'sessionrestore', 08:45:36 INFO - 'sessionrestore_no_auto_restore', 08:45:36 INFO - 'tabpaint']}, 08:45:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:45:36 INFO - 'tests': ['a11yr', 08:45:36 INFO - 'ts_paint', 08:45:36 INFO - 'tpaint', 08:45:36 INFO - 'sessionrestore', 08:45:36 INFO - 'sessionrestore_no_auto_restore', 08:45:36 INFO - 'tabpaint']}, 08:45:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:45:36 INFO - 'tests': ['a11yr', 08:45:36 INFO - 'ts_paint', 08:45:36 INFO - 'tpaint', 08:45:36 INFO - 'sessionrestore', 08:45:36 INFO - 'sessionrestore_no_auto_restore', 08:45:36 INFO - 'tabpaint']}, 08:45:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:45:36 INFO - 'tests': ['tsvgx', 08:45:36 INFO - 'tsvgr_opacity', 08:45:36 INFO - 'tart', 08:45:36 INFO - 'tscrollx', 08:45:36 INFO - 'cart']}, 08:45:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:45:36 INFO - 'tsvgr_opacity', 08:45:36 INFO - 'tart', 08:45:36 INFO - 'tscrollx', 08:45:36 INFO - 'cart']}, 08:45:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:36 INFO - 'talos_options': ['--disable-e10s'], 08:45:36 INFO - 'tests': ['tp5o']}, 08:45:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:36 INFO - 'tests': ['tp5o']}, 08:45:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:36 INFO - 'talos_options': ['--disable-e10s', 08:45:36 INFO - '--xperf_path', 08:45:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:36 INFO - 'tests': ['tp5n']}, 08:45:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:36 INFO - 'talos_options': ['--xperf_path', 08:45:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:36 INFO - 'tests': ['tp5n']}}, 08:45:36 INFO - 'talos.zip': {'path': '', 08:45:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:36 INFO - Running post-action listener: _resource_record_post_action 08:45:36 INFO - ##### 08:45:36 INFO - ##### Running create-virtualenv step. 08:45:36 INFO - ##### 08:45:36 INFO - Running pre-action listener: _resource_record_pre_action 08:45:36 INFO - Running main action method: create_virtualenv 08:45:36 INFO - Creating virtualenv /builds/slave/test/build/venv 08:45:36 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 08:45:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:45:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:37 INFO - Using real prefix '/tools/python27' 08:45:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:45:37 INFO - Installing distribute.............................................................................................................................................................................................done. 08:45:40 INFO - Installing pip.................done. 08:45:40 INFO - Return code: 0 08:45:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:45:40 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')]} 08:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:40 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')]} 08:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:40 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 0x10bd71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe68bd5c1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc10e00>, '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 0x10ba79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bb20>, '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.v9KteHxHUi/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.5dxQRdO0l6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 08:45:40 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 08:45:40 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 08:45:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9KteHxHUi/Render', 08:45:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:40 INFO - 'HOME': '/Users/cltbld', 08:45:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:40 INFO - 'LOGNAME': 'cltbld', 08:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:40 INFO - 'MOZ_NO_REMOTE': '1', 08:45:40 INFO - 'NO_EM_RESTART': '1', 08:45:40 INFO - 'PAGER': '/bin/cat', 08:45:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:40 INFO - 'PWD': '/builds/slave/test', 08:45:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:40 INFO - 'SHELL': '/bin/bash', 08:45:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5dxQRdO0l6/Listeners', 08:45:40 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 08:45:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:40 INFO - 'USER': 'cltbld', 08:45:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:40 INFO - 'XPC_FLAGS': '0x0', 08:45:40 INFO - 'XPC_SERVICE_NAME': '0', 08:45:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:40 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 08:45:40 INFO - Cleaning up... 08:45:40 INFO - Return code: 0 08:45:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:45:40 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')]} 08:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:40 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')]} 08:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:40 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 0x10bd71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe68bd5c1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc10e00>, '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 0x10ba79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bb20>, '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.v9KteHxHUi/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.5dxQRdO0l6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 08:45:40 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 08:45:40 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 08:45:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9KteHxHUi/Render', 08:45:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:40 INFO - 'HOME': '/Users/cltbld', 08:45:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:40 INFO - 'LOGNAME': 'cltbld', 08:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:40 INFO - 'MOZ_NO_REMOTE': '1', 08:45:40 INFO - 'NO_EM_RESTART': '1', 08:45:40 INFO - 'PAGER': '/bin/cat', 08:45:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:40 INFO - 'PWD': '/builds/slave/test', 08:45:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:40 INFO - 'SHELL': '/bin/bash', 08:45:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5dxQRdO0l6/Listeners', 08:45:40 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 08:45:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:40 INFO - 'USER': 'cltbld', 08:45:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:40 INFO - 'XPC_FLAGS': '0x0', 08:45:40 INFO - 'XPC_SERVICE_NAME': '0', 08:45:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:41 INFO - Downloading/unpacking psutil>=0.7.1 08:45:41 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 08:45:41 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 08:45:41 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 08:45:41 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 08:45:41 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 08:45:41 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 08:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:45:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:44 INFO - Installing collected packages: psutil 08:45:44 INFO - Running setup.py install for psutil 08:45:44 INFO - building 'psutil._psutil_osx' extension 08:45:44 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 08:45:44 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 08:45:44 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 08:45:44 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 08:45:45 INFO - building 'psutil._psutil_posix' extension 08:45:45 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 08:45:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:45:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:45:45 INFO - ^ 08:45:45 INFO - 1 warning generated. 08:45:45 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 08:45:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:45 INFO - Successfully installed psutil 08:45:45 INFO - Cleaning up... 08:45:45 INFO - Return code: 0 08:45:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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')]} 08:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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', '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 0x10bd71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe68bd5c1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc10e00>, '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 0x10ba79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bb20>, '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.v9KteHxHUi/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.5dxQRdO0l6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 08:45: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:45: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 mozsystemmonitor==0.0.0 08:45:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9KteHxHUi/Render', 08:45:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:45 INFO - 'HOME': '/Users/cltbld', 08:45:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:45 INFO - 'LOGNAME': 'cltbld', 08:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:45 INFO - 'MOZ_NO_REMOTE': '1', 08:45:45 INFO - 'NO_EM_RESTART': '1', 08:45:45 INFO - 'PAGER': '/bin/cat', 08:45:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:45 INFO - 'PWD': '/builds/slave/test', 08:45:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:45 INFO - 'SHELL': '/bin/bash', 08:45:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5dxQRdO0l6/Listeners', 08:45:45 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 08:45:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:45 INFO - 'USER': 'cltbld', 08:45:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:45 INFO - 'XPC_FLAGS': '0x0', 08:45:45 INFO - 'XPC_SERVICE_NAME': '0', 08:45:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:45:48 INFO - Installing collected packages: mozsystemmonitor 08:45:48 INFO - Running setup.py install for mozsystemmonitor 08:45:48 INFO - Successfully installed mozsystemmonitor 08:45:48 INFO - Cleaning up... 08:45:48 INFO - Return code: 0 08:45:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:45:48 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')]} 08:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:48 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')]} 08:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:48 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 0x10bd71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe68bd5c1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc10e00>, '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 0x10ba79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bb20>, '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.v9KteHxHUi/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.5dxQRdO0l6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 08:45:48 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 08:45:48 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 08:45:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9KteHxHUi/Render', 08:45:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:48 INFO - 'HOME': '/Users/cltbld', 08:45:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:48 INFO - 'LOGNAME': 'cltbld', 08:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:48 INFO - 'MOZ_NO_REMOTE': '1', 08:45:48 INFO - 'NO_EM_RESTART': '1', 08:45:48 INFO - 'PAGER': '/bin/cat', 08:45:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:48 INFO - 'PWD': '/builds/slave/test', 08:45:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:48 INFO - 'SHELL': '/bin/bash', 08:45:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5dxQRdO0l6/Listeners', 08:45:48 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 08:45:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:48 INFO - 'USER': 'cltbld', 08:45:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:48 INFO - 'XPC_FLAGS': '0x0', 08:45:48 INFO - 'XPC_SERVICE_NAME': '0', 08:45:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:48 INFO - Downloading/unpacking blobuploader==1.2.4 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:51 INFO - Downloading blobuploader-1.2.4.tar.gz 08:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:45:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:45:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:52 INFO - Downloading docopt-0.6.1.tar.gz 08:45:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:45:52 INFO - Installing collected packages: blobuploader, requests, docopt 08:45:52 INFO - Running setup.py install for blobuploader 08:45:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:45:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:45:52 INFO - Running setup.py install for requests 08:45:52 INFO - Running setup.py install for docopt 08:45:53 INFO - Successfully installed blobuploader requests docopt 08:45:53 INFO - Cleaning up... 08:45:53 INFO - Return code: 0 08:45:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:53 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')]} 08:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:53 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')]} 08:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:53 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 0x10bd71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe68bd5c1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc10e00>, '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 0x10ba79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bb20>, '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.v9KteHxHUi/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.5dxQRdO0l6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 08:45:53 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 08:45:53 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 08:45:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9KteHxHUi/Render', 08:45:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:53 INFO - 'HOME': '/Users/cltbld', 08:45:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:53 INFO - 'LOGNAME': 'cltbld', 08:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:53 INFO - 'MOZ_NO_REMOTE': '1', 08:45:53 INFO - 'NO_EM_RESTART': '1', 08:45:53 INFO - 'PAGER': '/bin/cat', 08:45:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:53 INFO - 'PWD': '/builds/slave/test', 08:45:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:53 INFO - 'SHELL': '/bin/bash', 08:45:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5dxQRdO0l6/Listeners', 08:45:53 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 08:45:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:53 INFO - 'USER': 'cltbld', 08:45:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:53 INFO - 'XPC_FLAGS': '0x0', 08:45:53 INFO - 'XPC_SERVICE_NAME': '0', 08:45:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-wxWPEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-0fWeSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-QUG4zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-S3DY3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-4uaRHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-sOEEmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-KVcGbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-9ZKGK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-COYXVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-8_Pex0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-70uLHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-yYoMU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-DnOH59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-AImVEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-WOZxy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:55 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-dUTlf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:55 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-haqrng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:45:55 INFO - Running setup.py install for manifestparser 08:45:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:45:55 INFO - Running setup.py install for mozcrash 08:45:55 INFO - Running setup.py install for mozdebug 08:45:55 INFO - Running setup.py install for mozdevice 08:45:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:45:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:45:55 INFO - Running setup.py install for mozfile 08:45:55 INFO - Running setup.py install for mozhttpd 08:45:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:45:56 INFO - Running setup.py install for mozinfo 08:45:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:45:56 INFO - Running setup.py install for mozInstall 08:45:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:45:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:45:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:45:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:45:56 INFO - Running setup.py install for mozleak 08:45:56 INFO - Running setup.py install for mozlog 08:45:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:45:56 INFO - Running setup.py install for moznetwork 08:45:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:45:56 INFO - Running setup.py install for mozprocess 08:45:56 INFO - Running setup.py install for mozprofile 08:45:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:45:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:45:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:45:57 INFO - Running setup.py install for mozrunner 08:45:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:45:57 INFO - Running setup.py install for mozscreenshot 08:45:57 INFO - Running setup.py install for moztest 08:45:57 INFO - Running setup.py install for mozversion 08:45:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:45:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:57 INFO - Cleaning up... 08:45:57 INFO - Return code: 0 08:45:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:57 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 0x10bd71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe68bd5c1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc10e00>, '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 0x10ba79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bb20>, '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.v9KteHxHUi/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.5dxQRdO0l6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 08:45:57 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 08:45:57 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 08:45:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9KteHxHUi/Render', 08:45:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:57 INFO - 'HOME': '/Users/cltbld', 08:45:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:57 INFO - 'LOGNAME': 'cltbld', 08:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:57 INFO - 'MOZ_NO_REMOTE': '1', 08:45:57 INFO - 'NO_EM_RESTART': '1', 08:45:57 INFO - 'PAGER': '/bin/cat', 08:45:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:57 INFO - 'PWD': '/builds/slave/test', 08:45:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:57 INFO - 'SHELL': '/bin/bash', 08:45:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5dxQRdO0l6/Listeners', 08:45:57 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 08:45:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:57 INFO - 'USER': 'cltbld', 08:45:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:57 INFO - 'XPC_FLAGS': '0x0', 08:45:57 INFO - 'XPC_SERVICE_NAME': '0', 08:45:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-xHwgZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:58 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)) 08:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-_BU1ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:58 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)) 08:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-MbPSoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:58 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)) 08:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-gq_fbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:58 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)) 08:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-vNYX6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:58 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)) 08:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Xh5ShN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:58 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)) 08:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-_jd0eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:58 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)) 08:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-pxKjST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:58 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)) 08:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-8dcb3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:58 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)) 08:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-80JcKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:59 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)) 08:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-aoA7dY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:59 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)) 08:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Khxw6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:59 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)) 08:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-rWNbt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:59 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)) 08:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-iJrTqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:59 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)) 08:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-CrgN_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:59 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)) 08:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-DKPb9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:59 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)) 08:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-nFU9YV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:59 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 08:45:59 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 08:45:59 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 08:45:59 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 08:45:59 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 08:45:59 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 08:46:02 INFO - Downloading blessings-1.6.tar.gz 08:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:46:02 INFO - Installing collected packages: blessings 08:46:02 INFO - Running setup.py install for blessings 08:46:02 INFO - Successfully installed blessings 08:46:02 INFO - Cleaning up... 08:46:02 INFO - Return code: 0 08:46:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:46:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:02 INFO - Reading from file tmpfile_stdout 08:46:02 INFO - Current package versions: 08:46:02 INFO - blessings == 1.6 08:46:02 INFO - blobuploader == 1.2.4 08:46:02 INFO - docopt == 0.6.1 08:46:02 INFO - manifestparser == 1.1 08:46:02 INFO - mozInstall == 1.12 08:46:02 INFO - mozcrash == 0.17 08:46:02 INFO - mozdebug == 0.1 08:46:02 INFO - mozdevice == 0.48 08:46:02 INFO - mozfile == 1.2 08:46:02 INFO - mozhttpd == 0.7 08:46:02 INFO - mozinfo == 0.9 08:46:02 INFO - mozleak == 0.1 08:46:02 INFO - mozlog == 3.1 08:46:02 INFO - moznetwork == 0.27 08:46:02 INFO - mozprocess == 0.22 08:46:02 INFO - mozprofile == 0.28 08:46:02 INFO - mozrunner == 6.11 08:46:02 INFO - mozscreenshot == 0.1 08:46:02 INFO - mozsystemmonitor == 0.0 08:46:02 INFO - moztest == 0.7 08:46:02 INFO - mozversion == 1.4 08:46:02 INFO - psutil == 3.1.1 08:46:02 INFO - requests == 1.2.3 08:46:02 INFO - wsgiref == 0.1.2 08:46:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:02 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')]} 08:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:02 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')]} 08:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:02 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 0x10bd71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe68bd5c1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc10e00>, '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 0x10ba79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bb20>, '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.v9KteHxHUi/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.5dxQRdO0l6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 08:46:02 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 08:46:02 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 08:46:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9KteHxHUi/Render', 08:46:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:02 INFO - 'HOME': '/Users/cltbld', 08:46:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:02 INFO - 'LOGNAME': 'cltbld', 08:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:02 INFO - 'MOZ_NO_REMOTE': '1', 08:46:02 INFO - 'NO_EM_RESTART': '1', 08:46:02 INFO - 'PAGER': '/bin/cat', 08:46:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:02 INFO - 'PWD': '/builds/slave/test', 08:46:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:02 INFO - 'SHELL': '/bin/bash', 08:46:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5dxQRdO0l6/Listeners', 08:46:02 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 08:46:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:02 INFO - 'USER': 'cltbld', 08:46:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:02 INFO - 'XPC_FLAGS': '0x0', 08:46:02 INFO - 'XPC_SERVICE_NAME': '0', 08:46:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:03 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)) 08:46:03 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)) 08:46:03 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)) 08:46:03 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)) 08:46:03 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)) 08:46:03 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)) 08:46:03 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)) 08:46:03 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)) 08:46:03 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)) 08:46:03 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)) 08:46:03 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)) 08:46:03 INFO - Cleaning up... 08:46:03 INFO - Return code: 0 08:46:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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')]} 08:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe68bd5c1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc10e00>, '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 0x10ba79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bb20>, '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.v9KteHxHUi/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.5dxQRdO0l6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 08:46: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', 'jsonschema'] in /builds/slave/test/build 08:46: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 jsonschema 08:46:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9KteHxHUi/Render', 08:46:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:03 INFO - 'HOME': '/Users/cltbld', 08:46:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:03 INFO - 'LOGNAME': 'cltbld', 08:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:03 INFO - 'MOZ_NO_REMOTE': '1', 08:46:03 INFO - 'NO_EM_RESTART': '1', 08:46:03 INFO - 'PAGER': '/bin/cat', 08:46:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:03 INFO - 'PWD': '/builds/slave/test', 08:46:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:03 INFO - 'SHELL': '/bin/bash', 08:46:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5dxQRdO0l6/Listeners', 08:46:03 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 08:46:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:03 INFO - 'USER': 'cltbld', 08:46:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:03 INFO - 'XPC_FLAGS': '0x0', 08:46:03 INFO - 'XPC_SERVICE_NAME': '0', 08:46:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:03 INFO - Downloading/unpacking jsonschema 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:46:05 INFO - Downloading/unpacking functools32 (from jsonschema) 08:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:06 INFO - Downloading functools32-3.2.3-2.tar.gz 08:46:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:46:06 INFO - warning: no files found matching '*.txt' 08:46:06 INFO - no previously-included directories found matching 'build' 08:46:06 INFO - no previously-included directories found matching 'dist' 08:46:06 INFO - no previously-included directories found matching '.git*' 08:46:06 INFO - Installing collected packages: jsonschema, functools32 08:46:06 INFO - Running setup.py install for functools32 08:46:06 INFO - warning: no files found matching '*.txt' 08:46:06 INFO - no previously-included directories found matching 'build' 08:46:06 INFO - no previously-included directories found matching 'dist' 08:46:06 INFO - no previously-included directories found matching '.git*' 08:46:06 INFO - Successfully installed jsonschema functools32 08:46:06 INFO - Cleaning up... 08:46:06 INFO - Return code: 0 08:46:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:46:06 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')]} 08:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:06 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')]} 08:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:06 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 0x10bd71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe68bd5c1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc10e00>, '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 0x10ba79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bb20>, '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.v9KteHxHUi/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.5dxQRdO0l6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 08:46:06 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 08:46:06 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 08:46:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9KteHxHUi/Render', 08:46:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:06 INFO - 'HOME': '/Users/cltbld', 08:46:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:06 INFO - 'LOGNAME': 'cltbld', 08:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:06 INFO - 'MOZ_NO_REMOTE': '1', 08:46:06 INFO - 'NO_EM_RESTART': '1', 08:46:06 INFO - 'PAGER': '/bin/cat', 08:46:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:06 INFO - 'PWD': '/builds/slave/test', 08:46:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:06 INFO - 'SHELL': '/bin/bash', 08:46:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5dxQRdO0l6/Listeners', 08:46:06 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 08:46:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:06 INFO - 'USER': 'cltbld', 08:46:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:06 INFO - 'XPC_FLAGS': '0x0', 08:46:06 INFO - 'XPC_SERVICE_NAME': '0', 08:46:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:07 INFO - Downloading/unpacking flake8 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:46:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:46:09 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 08:46:09 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 08:46:09 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 08:46:09 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 08:46:09 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 08:46:09 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 08:46:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:46:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:46:09 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 08:46:09 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 08:46:09 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 08:46:09 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 08:46:09 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 08:46:09 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 08:46:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:46:10 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 08:46:10 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 08:46:10 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 08:46:10 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 08:46:10 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 08:46:10 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 08:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:46:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:46:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:46:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:46:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:46:10 INFO - no previously-included directories found matching 'docs/_build' 08:46:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:46:10 INFO - Running setup.py install for pep8 08:46:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:46:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:46:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:46:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:46:10 INFO - no previously-included directories found matching 'docs/_build' 08:46:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:46:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:46:10 INFO - Cleaning up... 08:46:11 INFO - Return code: 0 08:46:11 INFO - Running post-action listener: _resource_record_post_action 08:46:11 INFO - Running post-action listener: _start_resource_monitoring 08:46:11 INFO - Starting resource monitoring. 08:46:11 INFO - ##### 08:46:11 INFO - ##### Running install step. 08:46:11 INFO - ##### 08:46:11 INFO - Running pre-action listener: _resource_record_pre_action 08:46:11 INFO - Running main action method: install 08:46:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:11 INFO - Reading from file tmpfile_stdout 08:46:11 INFO - Detecting whether we're running mozinstall >=1.0... 08:46:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:46:11 INFO - Reading from file tmpfile_stdout 08:46:11 INFO - Output received: 08:46:11 INFO - Usage: mozinstall [options] installer 08:46:11 INFO - Options: 08:46:11 INFO - -h, --help show this help message and exit 08:46:11 INFO - -d DEST, --destination=DEST 08:46:11 INFO - Directory to install application into. [default: 08:46:11 INFO - "/builds/slave/test"] 08:46:11 INFO - --app=APP Application being installed. [default: firefox] 08:46:11 INFO - mkdir: /builds/slave/test/build/application 08:46:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:46:43 INFO - Reading from file tmpfile_stdout 08:46:43 INFO - Output received: 08:46:43 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:46:43 INFO - Running post-action listener: _resource_record_post_action 08:46:43 INFO - ##### 08:46:43 INFO - ##### Running run-tests step. 08:46:43 INFO - ##### 08:46:43 INFO - Running pre-action listener: _resource_record_pre_action 08:46:43 INFO - Running main action method: run_tests 08:46:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:46:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:46:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:46:43 INFO - 2016-05-25 08:46:43.664 screenresolution[1642:7374] starting screenresolution argv=screenresolution get 08:46:43 INFO - 2016-05-25 08:46:43.667 screenresolution[1642:7374] Display 0: 1600x1200x32@60 08:46:43 INFO - 2016-05-25 08:46:43.673 screenresolution[1643:7376] starting screenresolution argv=screenresolution list 08:46:43 INFO - Available Modes on Display 0 08:46:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:46:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:46:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:46:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:46:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:46:43 INFO - Intel Iris: 08:46:43 INFO - Chipset Model: Intel Iris 08:46:43 INFO - Type: GPU 08:46:43 INFO - Bus: Built-In 08:46:43 INFO - VRAM (Dynamic, Max): 1536 MB 08:46:43 INFO - Vendor: Intel (0x8086) 08:46:43 INFO - Device ID: 0x0a2e 08:46:43 INFO - Revision ID: 0x0009 08:46:43 INFO - Displays: 08:46:43 INFO - Display: 08:46:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:46:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:46:43 INFO - Display Serial Number: 1600x1200 60 08:46:43 INFO - Main Display: Yes 08:46:43 INFO - Mirror: Off 08:46:43 INFO - Online: Yes 08:46:43 INFO - Rotation: Supported 08:46:43 INFO - Return code: 0 08:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:46:43 INFO - Python 2.7.3 08:46:43 INFO - Return code: 0 08:46:43 INFO - grabbing minidump binary from tooltool 08:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:43 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 0x10bc10e00>, '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 0x10ba79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:46:43 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 08:46:43 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 08:46:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:46:43 INFO - Return code: 0 08:46:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:46:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:46:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:46:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:46:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:46:45 INFO - Return code: 0 08:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0158 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:46:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9KteHxHUi/Render', 08:46:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:45 INFO - 'HOME': '/Users/cltbld', 08:46:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:45 INFO - 'LOGNAME': 'cltbld', 08:46:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:46:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:45 INFO - 'MOZ_NO_REMOTE': '1', 08:46:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:46:45 INFO - 'NO_EM_RESTART': '1', 08:46:45 INFO - 'PAGER': '/bin/cat', 08:46:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:45 INFO - 'PWD': '/builds/slave/test', 08:46:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:46:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:45 INFO - 'SHELL': '/bin/bash', 08:46:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5dxQRdO0l6/Listeners', 08:46:45 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 08:46:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:45 INFO - 'USER': 'cltbld', 08:46:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:45 INFO - 'XPC_FLAGS': '0x0', 08:46:45 INFO - 'XPC_SERVICE_NAME': '0', 08:46:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:46:45 INFO - mozversion application_buildid: 20160525071041 08:46:45 INFO - mozversion application_changeset: b01ee9309ba0d1d2ac65e4f2d8e25899ca817ec4 08:46:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:46:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:46:45 INFO - mozversion application_name: Firefox 08:46:45 INFO - mozversion application_remotingname: firefox-dev 08:46:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:46:45 INFO - mozversion application_vendor: Mozilla 08:46:45 INFO - mozversion application_version: 48.0a2 08:46:45 INFO - mozversion platform_buildid: 20160525071041 08:46:45 INFO - mozversion platform_changeset: b01ee9309ba0d1d2ac65e4f2d8e25899ca817ec4 08:46:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:46:45 INFO - mozversion platform_version: 48.0a2 08:46:45 INFO - using testdate: 1464191205 08:46:45 INFO - actual date: 1464191205 08:46:45 INFO - starting webserver on 'localhost:49270' 08:46:45 INFO - SUITE-START | Running 2 tests 08:46:45 INFO - TEST-START | dromaeo_css 08:46:45 INFO - operating with platform_type : mac_ 08:46:45 INFO - Initialising browser for dromaeo_css test... 08:46:45 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpVkAjjO/profile http://localhost:49270/getInfo.html) 08:46:48 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 08:46:48 INFO - PROCESS | 1661 | colorDepth:24 08:46:48 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 08:46:48 INFO - PROCESS | 1661 | __metrics 08:46:48 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 08:46:49 INFO - TEST-INFO | 1661: exit 0 08:46:49 INFO - Browser initialized. 08:46:49 INFO - Running cycle 1/1 for dromaeo_css test... 08:46:49 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpVkAjjO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:00 INFO - PROCESS | 1664 | RSS: Main: 221188096 08:47:00 INFO - PROCESS | 1664 | 08:47:50 INFO - PROCESS | 1664 | 1464191270612 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] 08:50:01 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 08:50:03 INFO - PROCESS | 1664 | RSS: Main: 232841216 08:50:03 INFO - PROCESS | 1664 | 08:53:04 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 08:53:05 INFO - PROCESS | 1664 | RSS: Main: 243343360 08:53:05 INFO - PROCESS | 1664 | 08:56:07 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 08:56:07 INFO - PROCESS | 1664 | RSS: Main: 245772288 08:56:07 INFO - PROCESS | 1664 | 08:59:09 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 08:59:10 INFO - PROCESS | 1664 | RSS: Main: 247496704 08:59:10 INFO - PROCESS | 1664 | 09:02:12 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 09:02:13 INFO - PROCESS | 1664 | RSS: Main: 249860096 09:02:13 INFO - PROCESS | 1664 | 09:05:15 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 09:05:15 INFO - PROCESS | 1664 | RSS: Main: 251289600 09:05:15 INFO - PROCESS | 1664 | 09:05:15 INFO - PROCESS | 1664 | __start_tp_report 09:05:15 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 09:05:15 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 09:05:15 INFO - PROCESS | 1664 | |i|pagename|runs| 09:05:15 INFO - PROCESS | 1664 | |0;dojo.html;2782.65216847894;2839.1766387747552;3478.634743351948;3495.1262184453894;3497.8806781829794;5187.533122019017;5198.986197691452;5705.828825135242;5728.885422291557;5737.713114344287;5637.098064309711;5665.461781130796;5707.058335374669;5719.799807006755;5738;4301.892452688677;5213.6089793265655;5273;5284.894302113956;5306.283651707028;5127.487251274862;5281.996420680059;5311.9468805311835;5364.651297665659;5407.3781515125875;5186.1442861927735;5189.065968125736;5206.843794686147;5226.947730522684;5329.573634109282;5256.5794736421185;5308.416074231832;5316.441773613754;5319.627626066177;5349.491798279177;5184.429712731597;5267.209918512254;5283.815066472655;5296.682199068068;5316.93661267748;5383.596230282745;5538.47384498472;5627.2684551008515;5634.4365563443735;5658.943410565883;6151.446369826737;6165.969170154121;6217.533684973645;6219.160413344186;6232.8130156095385;5237.397699264595;6228.470580000705;6241.65670888101;6246.718897649571;6249.343818898996;4244.469441319835;5700.287464067033;5882.941170588325;5903.557233207526;5915.319738230116;6249.312575616678;6275.309715931244;6343.333949935282;6367.363263673688;6387.904181437282;6135.202423684892;6161.260648722182;6205.751769929152;6218.9378106219265;6237.313895471494;6170.167027451326;6173.8456538586;6207.720652570645;6231.626102433868;6242.15730876335;6175.752969881154;6218.440340369298;6226.937730622726;6238.937610623836;6255;6083.148359229712;6225.159603453566;6235;6239.656818874914;6258.249010118815;4944.3572335596145;4996.950030499721;5004.574611158092;5007.37407824022;5039.118154322979;4441.489228738672;4451.399061126771;4482.708623939434;4489;4492.842750503717;5638;5734.4552267535355;5769.826905192851;5785.652860828363;5839.007368747239;6132.630864714964;6174.845628859314;6176.320604733476;6246.219222597176;6281.937180628227;5820.679862607512;5829.300483941869;5841.474267315962;5846.561507886926;5850.912236316459;5322.3879253885525;5400.108982017923;5469.206964990054;5469.343678758574;5476.890462190734;6450.451711604473;6470.482361410982;6502.772402965874;6507.446867016357;6510.609363438209;6243.001119820807;6246.3753624637175;6251.124842521959;6257.56197066201;6257.937420625735;5304.575633949197;6391.753608046386;6404.359564043559;6456.870862582816;6482.643454610042;6174.598651087665;6175.96912015437;6191.442770150528;6200.968995154995;6213.068039794067;6229.283632382334;6234.597215626629;6235.688215589294;6255.37446255389;6271.341509141657;5774;6053.788117416046;6116.0010150213275;6166.1983942087245;6180.845478863064;6101.359357267423;6133.926562851572;6146.754129834757;6158.476529494864;6168.784092556739;5872.735726892215;5970.044792833126;6017.729202185825;6074.787382441594;6088.695565221809;6044.667543285162;6093.29927058394;6141.359215537183;6158.168647232566;6175.475084617858;5973.880522389441;6052.2132122825515;6052.273727152769;6077.756889724538;6078.665673388006 09:05:15 INFO - PROCESS | 1664 | |1;ext.html;507.5660310434578;576.8442520519458;597.4145337569182;599.989018503821;606.6238931862246;34987;35113;40397.394039089435;41480.58519414805;41515.79242103789;37012;43403;43471.13057738851;43536.78231608838;43627.127457450835;9669.854952175705;9779.804403911918;9790.657326993522;9853.802923941517;9879.110880020797;9768.706938791813;9818.067283608081;9830.508474576278;9848.310618256724;9925.255605829556;9840.655577054804;9841.50792460374;9853;9911.553980070878;9957.45234012129;9798.90201097987;9866.654667086654;9918.958509356522;9939.5030248488;9940.801183976353;9655.324127311022;9662.468564228964;9710.320277580573;9788.755281117958;9802.509874506246;39028.609713902784;39357.819265422084;39441.40837887434;39586.802065989774;39834;3124.297033167542;3308.106811160997;3309.271960168759;3424.520567120605;3439.914002149941;28954.565681514796;29128.271793205127;29402.41195176106;29759.553606695918;29781.255468613243;2734.6308248386413;2765.778737700979;2792.0925699147856;2794.636697229347;2816.380396312808;467851;468698;471784;473965;475077;63539;63725.681371592844;64140.679296603215;64167;64205.715885682024;67279.3272067273;70298;71478.64260678767;71603;71704.64147679228;17473.126343682765;17715.379961701277;17771.378001769877;17854.821451785574;17927.103644817707;13392.866071339162;13404.061715680004;13497.662558436117;13508.189508629514;13519.121257118255;19809.30667426662;20124.798752012586;20169.39491815248;20205.37330147101;20238.797612023987;8555.315574754004;8631.741047768577;8669.479831210148;8670.263027642595;8772.561371931379;965.666844938495;994.721477986165;1047.2930771729052;1053.757635743783;1067.2902519824386;30061.098167055025;30459.390812183632;30471.695283046887;30948.845255773576;30991.380172396424;1106.2035334559105;1138.4364739454024;1169.7718944805852;1194.4923407551755;1204.2232759869835;13329.200247985153;15317;15749.291281892343;15837.524874253791;16198;624954;628609;631996;635535;637456;59415.70292148511;61371.079433808525;61388.38611613827;61463.6926815372;61473.38526614677;1498.4380857178558;1515.6892836968395;1516.8634822865995;1517.3475405575489;1524.6798172383924;30003;30619.423044256244;30642.23394415068;30695.2326191847;30733.53899691551;53203.40389788312;53371.4662853382;53549.73225133849;54319;54392.45607544032;568649;568923;573686;573818;574523;27400.040998564953;27764.861175693994;27788.027419040238;27839.30401739973;28164.85917570481;45175.870603235184;45241;47838.04323913572;48171;48253.75873120612;30068.54897176588;38928.42068674362;38954.831355059396;39079.609203907596;40559.797201013804;38094.23811523809;38273.61726382701;38519.80740096282;38550.036249093995;39227.80386098166;37849.4322585156;37948;38878.22243555057;39477.01307467336;39545.20909581735;30111.849440752656;31878.52182217222;32365;32475.67524324821;33594.32811343808;24947.87526062358;25160.993560257386;25176.622350665122;25312.873435632704;25574.360640984123 09:05:15 INFO - PROCESS | 1664 | |2;jquery.html;350.70891160336924;404.2400287459577;405.93505039193735;412.6121445840909;413.7600191888705;14901.552953411388;16071.758923616155;19587.314443994463;20219.696704549424;20304.89847550762;18476.16857241424;20293.79706202941;21186.728796272197;21396.8930155349;22172.667409988822;5748.511376533;5769.855753606152;6040.063790112539;6060.969635162033;6076;5836.007878660638;5923.992921203384;5997.340292567836;6018.9097163542365;6037.849053773669;5202.739863006835;5307.52232299093;5680.829575112753;5825.213596164527;5996.520278377741;5834.27071616048;5906.586538942276;5971.820845374646;5994.310654274771;5995.6702381369005;5164.793408263702;5190.636655434121;5203.687778733288;5253.6322457428;5283.735813209324;26161.869190653924;26200.60699089515;26626.866865665546;27144.728552714616;27643.723562764317;2094.895255237247;2127.7553081395527;2133.6052830226304;2147.8174355179826;2296.517731276434;14711.63220919475;14790.556283311518;15120.319585618563;15282.541523754306;15567;1689.0794516988271;1716.3048965169125;1764.7617571627795;1781.5189898727401;1796.97304540432;108504;110638.44680776545;113363;113884.29173562404;114466.42766786112;11527.308361498337;11895.464704088337;11995.340256285988;12015.459304331325;12096.879031209752;15340.539783806504;15377.231138443032;15439.922800385926;15450.38198472071;15475.303611337516;7701.614919254127;8900.198982091642;9057.456552606733;9079.636814527477;9131;8912.821743565222;9090.999990001095;9091.727248182566;9152.496612686233;9184.8622270666;4658.231391820312;4735.573798358096;4764.928526072112;4787.329773831666;4812;1665.6751933372875;1953.238237087537;1993.312307253995;1996.1316827180224;2005.1377907499916;786.8032991752062;865.4201684871151;947.4126041853957;955.2310390135868;1005.7535903703639;20711;20909.581808363746;21881.562368752537;22083.889580551993;22175.889120554293;818.2635627934907;953.9475328856979;959.3476436023572;1018.3126389686931;1073.2058276875057;10876.293040952312;11033.282836615594;11065.557377704963;11105.66682999495;11201.551937922392;584624;621249;623531;630571;634763;116995.0751231226;126396.36801815932;134310;135463.32268338595;135595;927.4806108579218;942.3874481587023;1007.2294694558668;1071.328727185593;1075.833245846895;13367.26480043568;15628.531144065697;15818.367265309258;18065.458036258933;18998.620027599096;53489.46510534845;56276;56912.43087569237;56933.861322774144;58712.412875870694;79667.20332796598;80426.59786701029;81749.18250817416;82756;83057.58471207606;6750.797476075725;8111;8359.916400835913;8489.490630562186;8583.141685831368;10527.631532896312;12605.621831345074;12728.490860365482;12749.553765618159;12875.80686289725;9227.76930576741;11004;11027.558897644325;11150.665480035612;11188.04901583342;9255.953720231355;10548.525316360628;10705.518251678848;10840.566377344818;10946.014858662758;9645.71062868115;11217.831732523855;11252.70593881714;11262.04272636835;11708.941455292668;7063.1524217094275;8278.503289802631;8532.274756645755;8593.69922052725;8629.69796057135;10557.736056598647;11386.316820990767;11421.37182454973;11555.653330400102;11668.183227174017 09:05:15 INFO - PROCESS | 1664 | |3;mootools.html;1611.0897343001204;1635.0353291557979;1884.4252502986583;1941.737865388173;1993.7208790769305;8001.239882211181;8649.567521623925;8816.559172041396;9029.683961061364;9041.909580904188;8606.397552171351;8626.827463450727;8718.302535797136;8723.520206388646;8726;2427.029188324671;2441.2676197140877;2449.3876530867283;2451.5464639041747;2456;1964.7936966618443;2434.184548176363;2436.0134145670945;2436.6954130733657;2463.4949835283815;2426.8665223412704;2434.330559096245;2451.963220551693;2460.9507809843794;2480.900763969439;2457.8156638252026;2460.753924607543;2468.4322605800767;2474.7030356357354;2479.690038745157;2288.096202000217;2294.931152065424;2330.34750269923;2331.1491305673476;2350.0129945422964;8839.89501312336;8858.512781796999;8865.423747456394;8879.644814207424;8882.067382924764;4487.304467807495;5437.075697131497;5466.01611709892;5482.890342193174;5488.121900495941;3107.6115485564305;3441.8107004114763;3535.292941411728;3554.8578056877695;3670.1925576373155;1056.1234175634206;1070.293606219899;1074.3285446595878;1075.0432115417207;1078.8435676826894;12130.696732581668;12352.25886446816;12362.938185309196;12373.752524949541;12388.752224955451;4781.091592597395;4817.2774083887;4901.583365413909;4931.0630980113665;4973.1297023020825;10268.178545716324;10458.895411045944;10462.633807816843;10489.265751397481;10508.579656813794;5438.374586922555;5469.835904922858;5489.39616642169;5503.972480137573;5504.752286147133;4399.670024748157;4773.976130119397;4944.9258261126115;4958.801647934042;4998.025385049953;4135.338345864708;4158.126793373365;4193.182329445729;4238.682098842537;4243.8090285937205;1372.9107608005447;1392.373431955624;1394.8953828462907;1396.0716123777777;1407.422956587794;820.2863508747428;820.8727647214691;876.9035406105323;932.9253659707207;966.4201479112477;5185.559227465632;5973.133895585116;6037.909431358533;6080.604760690541;6227.034809604518;978.9412635241908;1000.7632940378248;1003.4882210072915;1012.2661070723666;1047.4972013433442;3519.5671883592813;4112.280350938574;4150.937735933903;4152.148809494047;4168.541460439349;10863.293885897392;11120.443977801078;11177.385243811506;11209.439528023566;11223.494942727597;10566.207534434949;10750.516226769814;10859.728506787236;10972.725681857857;10998.890011099787;8001.8799718004275;8459.407841451162;8497.532635705096;8528.40301178924;8572.52851093196;5965.254343207099;5998.25021872266;6036.396360364104;6092.360302168208;6110.633361998294;9265;9450.480223587494;9583;9630.951845241008;9676.9032309676;9442.244620430487;9767.462789546644;9778.973207813076;9785.07041831025;9903.405795652285;7355.852882942204;8071.959640201761;8191.672333106609;8272.917270827214;8307.003159620885;8204.261616454547;8343.833123337621;8361;8415.074341822517;8434.915650843413;6898.793036208721;7067.681954312171;7387.741429049957;7512.32389084985;7637.770866874002;7254.093238345207;7254.927450725636;7277.781666550012;7295.744648937261;7342.889856652261;6915.481338899502;6926.549774264657;6940;6941.167059952838;6993;4732.858014259577;4739.691920025188;4850.46644869057;4858.951410485991;4859.611231101574;4932;4936.111499930047;4959.900801984012;5043.167877300204;5189.584833213258 09:05:15 INFO - PROCESS | 1664 | |4;prototype.html;309.94421004219237;314.28186593633546;327.2489636284726;330.2750462734296;335.163766402825;4848.927266091011;6296.803607314607;6663.400293973541;6768.458523318135;6793.184817821868;5780.4797568218855;6662.700178491968;6671.699773510191;6680.46556275498;6702.229243636971;4777.140114779339;4865.756712164378;4987.700737955734;5007.624428167884;5018.071656743496;4903.877403064934;4925.38432695913;4930.063287975273;4939.901201975958;4959.156943319645;4870.464248932614;4905.730184839832;4906.31311616374;4917.434495033063;4924.581410580105;4895.314655948152;4905.484924082955;4922.409310882681;4926.0394223126505;4950.8762280943265;4259.51015633203;4263.658907287409;4271.188474189925;4277.721948073366;4283.378910058055;6236.6258024518675;6353.5234857385885;6391.968040159816;6398.392152745481;6565.080888675589;4448.777561121931;4818.638602104821;5879.176915231871;5879.441453061952;5883.911741323884;7219.8917016244795;7223.711051557932;7237.638118094074;7246.565206087652;7262.854742905165;4816.662833601649;4819.397575303087;4822.493638167977;4823.276508523714;4844.346013288232;6213.906791398133;6229.314775374705;7644.5093206824695;7679.769606911802;7691.692332306701;4021.738586991836;4727.220008698595;4903.239997800347;4914.115459217375;4933.161362568372;4966.875828104254;5018.799248030111;5021.196608542616;5022.472640372781;5036.370453693288;5868.589198756132;5934.406559344117;5935;5939.46544810969;5954.4045595440975;7256.419486441072;7256.818579535554;7285.562866228043;7295.088113985752;7306.707731690779;1725.1374312843577;1754.0703427183614;1756.631107467446;1757.4903278049478;1768.2926829268395;1020.9489525523694;1067.3382502848128;1069.8769641491172;1129.4014172488594;1144.6852115668091;6412.294647588761;6486.740530378732;6490.383413575702;6533.607983521004;6588.670566471657;7290.927090729131;7380.557166570023;7389.593572353465;7402.519496100801;7407.407407407394;6446.419822216023;6585.111010013587;6687.966560167265;6701.932980670228;6785.287544807823;3387.847546860348;4016.6786657067364;4032.3145065338963;4036.899077523027;4061.6750659947725;7916.08964969036;7975.481593696391;8012.839743205103;8019.318357939524;8032.558209298428;7566.843449616943;7841.921580784233;7872.33085187754;7928.246816552418;7930.6431210595665;7905.249001344748;7944.6822127114265;8025.9598702006115;8047.034355877332;8053.677852885936;6077.908831367445;7650.2349765023055;7654.617269136632;7677.654505547375;7693.4614576979075;7465;7474;7475.392790550058;7494.925050749423;7525.548467091992;7704.730334438268;7879.64541595641;8023;8024.277814996678;8032.799180020546;4704.153252414461;4742.051589682008;4776.140294746979;4786.832460863853;4799.304100905419;6104.481119104926;7533.284337987882;7610.353119984863;7611.314981651678;7622.123455802654;6580.8354791130605;7318.451116166202;7324.523905946096;7343.8898416522725;7356.154042284991;5817.94182058174;7051.365377116084;7171.533850299714;7269.873169658711;7288.927110728825;7061.752838650623;7108.964455177691;7109.111361079865;7160.391366733677;7354.043974283309;5840.94159058421;7267.60028198433;7298.233685463162;7311.890321645286;7318.890216646648;6895.965520172367;7056.682449289897;7083.929160708533;7114.466415018997;7185.353318201387 09:05:15 INFO - PROCESS | 1664 | |5;yui.html;678.9253182149963;718.8749606865259;738.3723834740468;742.1873049011338;765.288281897835;14813.259337033145;14816.6295842604;14921.328540215676;14929.253537323117;15023.39906403744;13430.194188348705;13864;13864.514741984032;13866.930665346685;13901.165930044204;721.4372789224414;891.656712165816;901.729481155654;901.9774505637379;928.4382948316239;878.6134100995573;904.5251243097393;907.587047893207;910.3809409601469;910.9362344635878;926.8702381666573;960.8414611589079;962.0523784072683;962.7593101724569;963.3016063354082;933.5658918602883;943.481085403029;957.4686049242667;958.9952050239774;960.3181740963959;687.9380855722959;709.9680514376865;714.957102573842;715.7065603102754;718.3642476408364;14598.41606335756;14921.477748278867;14949.103053816805;14959.700805983928;14981.925090374478;12511.74976500465;12532.749345013048;12582.056345774103;12738.172018818746;12738.745225095447;9920.40477571348;9987;10054.296199266055;10258.487075646188;10298.845517317246;3442.7934323940394;3451.0854623524788;3490.5462289902152;3567.161716996504;3728.4780130781714;79982.60008699978;80167.5991620044;81436;81438;81482.59258703727;9254.953725231331;9350.95324523373;9415.62337506492;9421.576029078571;9579.994100619335;21612.45968850791;21749.34751957444;21842.563148736936;21904.89047554752;22027;6411.871762564816;6415.326390728999;7296.416286697052;7330.816729581697;7504.849903001909;4109.856155034619;4125.154343359604;4127.504699436087;4133.318002529549;4134.4005119258145;2991.7457016153435;3276.39386713454;3441.6558344165883;3442.7762195457217;3526.100844284691;547.5811004581499;624.9906251406233;626.139058794158;638.9105525226472;648.5849056603778;519.1226826663003;555.8082461550758;578.3984655957756;581.4505292498549;605.9121427393003;8125.553094579855;8195.508269503849;8281.171882811792;8501.95749021251;8519.233269005696;512.3723438787456;513.2122192434595;517.3119750731518;586.4545972245852;588.5115354255958;3204.423203823334;3770.4155855842387;3854.5181852268465;3856.8842934712;3872.1481274119647;88862;89787;89915.55042224878;89937;91479.54260228656;53478;63041.84790760444;68124;77686;79362;54546.454535454934;59838.70080649569;64609;65510.672446637465;66372.6725465488;6596;7010.404115650227;7678.155402905788;7696.692132314644;7802.726904558313;48459.061637534105;48781.5121848777;49525.504744953534;49955.50044499509;50117.24824127714;61109.69445152746;62337.68831155815;65825.67087164533;66947.33052669605;67542;10153.84769228477;10368.948155259175;10369.585216591251;10371.377717336984;10378.377297362182;10829.783404331713;10863.511141998788;10891.727706807393;10903.890961090288;10988.890111098786;8537.231649151607;10170;10241.590336386462;10244.334118282288;10799.946000269949;10225.488725563544;10387.792244154924;10488;10626.681199564026;10650.946745266225;10039.548220330249;10137.138343240907;10194.43930583825;10196.13332866685;10310.226732994905;8765.956170219108;8879.91120088791;9054.818903622023;9137.862932056158;9224.262059035127;8810.911890881265;8837;8870.866936996079;8920.776980575538;8940.86588701183 09:05:15 INFO - PROCESS | 1664 | __end_tp_report 09:05:15 INFO - PROCESS | 1664 | __start_cc_report 09:05:15 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,416 09:05:15 INFO - PROCESS | 1664 | __end_cc_report 09:05:15 INFO - PROCESS | 1664 | __startTimestamp1464192315670__endTimestamp 09:05:15 INFO - PROCESS | 1664 | 09:05:15 INFO - PROCESS | 1664 | ------- Summary: start ------- 09:05:15 INFO - PROCESS | 1664 | Number of tests: 6 09:05:15 INFO - PROCESS | 1664 | 09:05:15 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5743.77 Median:6044.67 stddev:677.48 (11.2%) stddev-sans-first:638.49 09:05:15 INFO - PROCESS | 1664 | Values: 2782.7 2839.2 3478.6 3495.1 3497.9 5187.5 5199.0 5705.8 5728.9 5737.7 5637.1 5665.5 5707.1 5719.8 5738.0 4301.9 5213.6 5273.0 5284.9 5306.3 5127.5 5282.0 5311.9 5364.7 5407.4 5186.1 5189.1 5206.8 5226.9 5329.6 5256.6 5308.4 5316.4 5319.6 5349.5 5184.4 5267.2 5283.8 5296.7 5316.9 5383.6 5538.5 5627.3 5634.4 5658.9 6151.4 6166.0 6217.5 6219.2 6232.8 5237.4 6228.5 6241.7 6246.7 6249.3 4244.5 5700.3 5882.9 5903.6 5915.3 6249.3 6275.3 6343.3 6367.4 6387.9 6135.2 6161.3 6205.8 6218.9 6237.3 6170.2 6173.8 6207.7 6231.6 6242.2 6175.8 6218.4 6226.9 6238.9 6255.0 6083.1 6225.2 6235.0 6239.7 6258.2 4944.4 4997.0 5004.6 5007.4 5039.1 4441.5 4451.4 4482.7 4489.0 4492.8 5638.0 5734.5 5769.8 5785.7 5839.0 6132.6 6174.8 6176.3 6246.2 6281.9 5820.7 5829.3 5841.5 5846.6 5850.9 5322.4 5400.1 5469.2 5469.3 5476.9 6450.5 6470.5 6502.8 6507.4 6510.6 6243.0 6246.4 6251.1 6257.6 6257.9 5304.6 6391.8 6404.4 6456.9 6482.6 6174.6 6176.0 6191.4 6201.0 6213.1 6229.3 6234.6 6235.7 6255.4 6271.3 5774.0 6053.8 6116.0 6166.2 6180.8 6101.4 6133.9 6146.8 6158.5 6168.8 5872.7 5970.0 6017.7 6074.8 6088.7 6044.7 6093.3 6141.4 6158.2 6175.5 5973.9 6052.2 6052.3 6077.8 6078.7 09:05:15 INFO - PROCESS | 1664 | 09:05:15 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:69911.97 Median:39459.21 stddev:150097.45 (380.4%) stddev-sans-first:150428.05 09:05:15 INFO - PROCESS | 1664 | Values: 507.6 576.8 597.4 600.0 606.6 34987.0 35113.0 40397.4 41480.6 41515.8 37012.0 43403.0 43471.1 43536.8 43627.1 9669.9 9779.8 9790.7 9853.8 9879.1 9768.7 9818.1 9830.5 9848.3 9925.3 9840.7 9841.5 9853.0 9911.6 9957.5 9798.9 9866.7 9919.0 9939.5 9940.8 9655.3 9662.5 9710.3 9788.8 9802.5 39028.6 39357.8 39441.4 39586.8 39834.0 3124.3 3308.1 3309.3 3424.5 3439.9 28954.6 29128.3 29402.4 29759.6 29781.3 2734.6 2765.8 2792.1 2794.6 2816.4 467851.0 468698.0 471784.0 473965.0 475077.0 63539.0 63725.7 64140.7 64167.0 64205.7 67279.3 70298.0 71478.6 71603.0 71704.6 17473.1 17715.4 17771.4 17854.8 17927.1 13392.9 13404.1 13497.7 13508.2 13519.1 19809.3 20124.8 20169.4 20205.4 20238.8 8555.3 8631.7 8669.5 8670.3 8772.6 965.7 994.7 1047.3 1053.8 1067.3 30061.1 30459.4 30471.7 30948.8 30991.4 1106.2 1138.4 1169.8 1194.5 1204.2 13329.2 15317.0 15749.3 15837.5 16198.0 624954.0 628609.0 631996.0 635535.0 637456.0 59415.7 61371.1 61388.4 61463.7 61473.4 1498.4 1515.7 1516.9 1517.3 1524.7 30003.0 30619.4 30642.2 30695.2 30733.5 53203.4 53371.5 53549.7 54319.0 54392.5 568649.0 568923.0 573686.0 573818.0 574523.0 27400.0 27764.9 27788.0 27839.3 28164.9 45175.9 45241.0 47838.0 48171.0 48253.8 30068.5 38928.4 38954.8 39079.6 40559.8 38094.2 38273.6 38519.8 38550.0 39227.8 37849.4 37948.0 38878.2 39477.0 39545.2 30111.8 31878.5 32365.0 32475.7 33594.3 24947.9 25161.0 25176.6 25312.9 25574.4 09:05:15 INFO - PROCESS | 1664 | 09:05:15 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:35789.57 Median:22174.28 stddev:103120.32 (465.0%) stddev-sans-first:103375.26 09:05:15 INFO - PROCESS | 1664 | Values: 350.7 404.2 405.9 412.6 413.8 14901.6 16071.8 19587.3 20219.7 20304.9 18476.2 20293.8 21186.7 21396.9 22172.7 5748.5 5769.9 6040.1 6061.0 6076.0 5836.0 5924.0 5997.3 6018.9 6037.8 5202.7 5307.5 5680.8 5825.2 5996.5 5834.3 5906.6 5971.8 5994.3 5995.7 5164.8 5190.6 5203.7 5253.6 5283.7 26161.9 26200.6 26626.9 27144.7 27643.7 2094.9 2127.8 2133.6 2147.8 2296.5 14711.6 14790.6 15120.3 15282.5 15567.0 1689.1 1716.3 1764.8 1781.5 1797.0 108504.0 110638.4 113363.0 113884.3 114466.4 11527.3 11895.5 11995.3 12015.5 12096.9 15340.5 15377.2 15439.9 15450.4 15475.3 7701.6 8900.2 9057.5 9079.6 9131.0 8912.8 9091.0 9091.7 9152.5 9184.9 4658.2 4735.6 4764.9 4787.3 4812.0 1665.7 1953.2 1993.3 1996.1 2005.1 786.8 865.4 947.4 955.2 1005.8 20711.0 20909.6 21881.6 22083.9 22175.9 818.3 953.9 959.3 1018.3 1073.2 10876.3 11033.3 11065.6 11105.7 11201.6 584624.0 621249.0 623531.0 630571.0 634763.0 116995.1 126396.4 134310.0 135463.3 135595.0 927.5 942.4 1007.2 1071.3 1075.8 13367.3 15628.5 15818.4 18065.5 18998.6 53489.5 56276.0 56912.4 56933.9 58712.4 79667.2 80426.6 81749.2 82756.0 83057.6 6750.8 8111.0 8359.9 8489.5 8583.1 10527.6 12605.6 12728.5 12749.6 12875.8 9227.8 11004.0 11027.6 11150.7 11188.0 9256.0 10548.5 10705.5 10840.6 10946.0 9645.7 11217.8 11252.7 11262.0 11708.9 7063.2 8278.5 8532.3 8593.7 8629.7 10557.7 11386.3 11421.4 11555.7 11668.2 09:05:15 INFO - PROCESS | 1664 | 09:05:15 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5795.48 Median:4931.53 stddev:3239.77 (65.7%) stddev-sans-first:3233.60 09:05:15 INFO - PROCESS | 1664 | Values: 1611.1 1635.0 1884.4 1941.7 1993.7 8001.2 8649.6 8816.6 9029.7 9041.9 8606.4 8626.8 8718.3 8723.5 8726.0 2427.0 2441.3 2449.4 2451.5 2456.0 1964.8 2434.2 2436.0 2436.7 2463.5 2426.9 2434.3 2452.0 2461.0 2480.9 2457.8 2460.8 2468.4 2474.7 2479.7 2288.1 2294.9 2330.3 2331.1 2350.0 8839.9 8858.5 8865.4 8879.6 8882.1 4487.3 5437.1 5466.0 5482.9 5488.1 3107.6 3441.8 3535.3 3554.9 3670.2 1056.1 1070.3 1074.3 1075.0 1078.8 12130.7 12352.3 12362.9 12373.8 12388.8 4781.1 4817.3 4901.6 4931.1 4973.1 10268.2 10458.9 10462.6 10489.3 10508.6 5438.4 5469.8 5489.4 5504.0 5504.8 4399.7 4774.0 4944.9 4958.8 4998.0 4135.3 4158.1 4193.2 4238.7 4243.8 1372.9 1392.4 1394.9 1396.1 1407.4 820.3 820.9 876.9 932.9 966.4 5185.6 5973.1 6037.9 6080.6 6227.0 978.9 1000.8 1003.5 1012.3 1047.5 3519.6 4112.3 4150.9 4152.1 4168.5 10863.3 11120.4 11177.4 11209.4 11223.5 10566.2 10750.5 10859.7 10972.7 10998.9 8001.9 8459.4 8497.5 8528.4 8572.5 5965.3 5998.3 6036.4 6092.4 6110.6 9265.0 9450.5 9583.0 9631.0 9676.9 9442.2 9767.5 9779.0 9785.1 9903.4 7355.9 8072.0 8191.7 8272.9 8307.0 8204.3 8343.8 8361.0 8415.1 8434.9 6898.8 7067.7 7387.7 7512.3 7637.8 7254.1 7254.9 7277.8 7295.7 7342.9 6915.5 6926.5 6940.0 6941.2 6993.0 4732.9 4739.7 4850.5 4859.0 4859.6 4932.0 4936.1 4959.9 5043.2 5189.6 09:05:15 INFO - PROCESS | 1664 | 09:05:15 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5892.98 Median:6488.56 stddev:1899.86 (29.3%) stddev-sans-first:1858.40 09:05:15 INFO - PROCESS | 1664 | Values: 309.9 314.3 327.2 330.3 335.2 4848.9 6296.8 6663.4 6768.5 6793.2 5780.5 6662.7 6671.7 6680.5 6702.2 4777.1 4865.8 4987.7 5007.6 5018.1 4903.9 4925.4 4930.1 4939.9 4959.2 4870.5 4905.7 4906.3 4917.4 4924.6 4895.3 4905.5 4922.4 4926.0 4950.9 4259.5 4263.7 4271.2 4277.7 4283.4 6236.6 6353.5 6392.0 6398.4 6565.1 4448.8 4818.6 5879.2 5879.4 5883.9 7219.9 7223.7 7237.6 7246.6 7262.9 4816.7 4819.4 4822.5 4823.3 4844.3 6213.9 6229.3 7644.5 7679.8 7691.7 4021.7 4727.2 4903.2 4914.1 4933.2 4966.9 5018.8 5021.2 5022.5 5036.4 5868.6 5934.4 5935.0 5939.5 5954.4 7256.4 7256.8 7285.6 7295.1 7306.7 1725.1 1754.1 1756.6 1757.5 1768.3 1020.9 1067.3 1069.9 1129.4 1144.7 6412.3 6486.7 6490.4 6533.6 6588.7 7290.9 7380.6 7389.6 7402.5 7407.4 6446.4 6585.1 6688.0 6701.9 6785.3 3387.8 4016.7 4032.3 4036.9 4061.7 7916.1 7975.5 8012.8 8019.3 8032.6 7566.8 7841.9 7872.3 7928.2 7930.6 7905.2 7944.7 8026.0 8047.0 8053.7 6077.9 7650.2 7654.6 7677.7 7693.5 7465.0 7474.0 7475.4 7494.9 7525.5 7704.7 7879.6 8023.0 8024.3 8032.8 4704.2 4742.1 4776.1 4786.8 4799.3 6104.5 7533.3 7610.4 7611.3 7622.1 6580.8 7318.5 7324.5 7343.9 7356.2 5817.9 7051.4 7171.5 7269.9 7288.9 7061.8 7109.0 7109.1 7160.4 7354.0 5840.9 7267.6 7298.2 7311.9 7318.9 6896.0 7056.7 7083.9 7114.5 7185.4 09:05:15 INFO - PROCESS | 1664 | 09:05:15 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:17417.95 Median:30857.80 stddev:24449.16 (79.2%) stddev-sans-first:24485.44 09:05:15 INFO - PROCESS | 1664 | Values: 678.9 718.9 738.4 742.2 765.3 14813.3 14816.6 14921.3 14929.3 15023.4 13430.2 13864.0 13864.5 13866.9 13901.2 721.4 891.7 901.7 902.0 928.4 878.6 904.5 907.6 910.4 910.9 926.9 960.8 962.1 962.8 963.3 933.6 943.5 957.5 959.0 960.3 687.9 710.0 715.0 715.7 718.4 14598.4 14921.5 14949.1 14959.7 14981.9 12511.7 12532.7 12582.1 12738.2 12738.7 9920.4 9987.0 10054.3 10258.5 10298.8 3442.8 3451.1 3490.5 3567.2 3728.5 79982.6 80167.6 81436.0 81438.0 81482.6 9255.0 9351.0 9415.6 9421.6 9580.0 21612.5 21749.3 21842.6 21904.9 22027.0 6411.9 6415.3 7296.4 7330.8 7504.8 4109.9 4125.2 4127.5 4133.3 4134.4 2991.7 3276.4 3441.7 3442.8 3526.1 547.6 625.0 626.1 638.9 648.6 519.1 555.8 578.4 581.5 605.9 8125.6 8195.5 8281.2 8502.0 8519.2 512.4 513.2 517.3 586.5 588.5 3204.4 3770.4 3854.5 3856.9 3872.1 88862.0 89787.0 89915.6 89937.0 91479.5 53478.0 63041.8 68124.0 77686.0 79362.0 54546.5 59838.7 64609.0 65510.7 66372.7 6596.0 7010.4 7678.2 7696.7 7802.7 48459.1 48781.5 49525.5 49955.5 50117.2 61109.7 62337.7 65825.7 66947.3 67542.0 10153.8 10368.9 10369.6 10371.4 10378.4 10829.8 10863.5 10891.7 10903.9 10988.9 8537.2 10170.0 10241.6 10244.3 10799.9 10225.5 10387.8 10488.0 10626.7 10650.9 10039.5 10137.1 10194.4 10196.1 10310.2 8766.0 8879.9 9054.8 9137.9 9224.3 8810.9 8837.0 8870.9 8920.8 8940.9 09:05:15 INFO - PROCESS | 1664 | -------- Summary: end -------- 09:05:15 INFO - PROCESS | 1664 | 09:05:16 INFO - TEST-INFO | 1664: exit 0 09:05:16 INFO - TEST-OK | dromaeo_css | took 1110900ms 09:05:16 INFO - TEST-START | kraken 09:05:16 INFO - operating with platform_type : mac_ 09:05:16 INFO - Initialising browser for kraken test... 09:05:16 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpJTgJnJ/profile http://localhost:49270/getInfo.html) 09:05:18 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 09:05:18 INFO - PROCESS | 1675 | colorDepth:24 09:05:18 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 09:05:18 INFO - PROCESS | 1675 | __metrics 09:05:19 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:05:19 INFO - TEST-INFO | 1675: exit 0 09:05:19 INFO - Browser initialized. 09:05:19 INFO - Running cycle 1/1 for kraken test... 09:05:19 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpJTgJnJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:31 INFO - PROCESS | 1678 | RSS: Main: 221147136 09:05:31 INFO - PROCESS | 1678 | 09:05:34 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 09:05:35 INFO - PROCESS | 1678 | RSS: Main: 232894464 09:05:35 INFO - PROCESS | 1678 | 09:05:38 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 09:05:39 INFO - PROCESS | 1678 | RSS: Main: 242384896 09:05:39 INFO - PROCESS | 1678 | 09:05:42 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 09:05:43 INFO - PROCESS | 1678 | RSS: Main: 245751808 09:05:43 INFO - PROCESS | 1678 | 09:05:45 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 09:05:45 INFO - PROCESS | 1678 | RSS: Main: 246931456 09:05:45 INFO - PROCESS | 1678 | 09:05:47 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:05:48 INFO - PROCESS | 1678 | RSS: Main: 247365632 09:05:48 INFO - PROCESS | 1678 | 09:05:51 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 09:05:51 INFO - PROCESS | 1678 | RSS: Main: 247238656 09:05:51 INFO - PROCESS | 1678 | 09:05:54 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 09:05:55 INFO - PROCESS | 1678 | RSS: Main: 247386112 09:05:55 INFO - PROCESS | 1678 | 09:05:58 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 09:05:59 INFO - PROCESS | 1678 | RSS: Main: 247627776 09:05:59 INFO - PROCESS | 1678 | 09:06:00 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:06:01 INFO - PROCESS | 1678 | RSS: Main: 247136256 09:06:01 INFO - PROCESS | 1678 | 09:06:03 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:06:03 INFO - PROCESS | 1678 | RSS: Main: 247226368 09:06:03 INFO - PROCESS | 1678 | 09:06:05 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:06:06 INFO - PROCESS | 1678 | RSS: Main: 247496704 09:06:06 INFO - PROCESS | 1678 | 09:06:09 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:06:10 INFO - PROCESS | 1678 | RSS: Main: 247513088 09:06:10 INFO - PROCESS | 1678 | 09:06:12 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:06:13 INFO - PROCESS | 1678 | RSS: Main: 247459840 09:06:13 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 09:06:15 INFO - PROCESS | 1678 | RSS: Main: 249626624 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | __start_tp_report 09:06:15 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 09:06:15 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 09:06:15 INFO - PROCESS | 1678 | |i|pagename|runs| 09:06:15 INFO - PROCESS | 1678 | |0;ai-astar;116;128;151;156;169;173;109;116;119;172 09:06:15 INFO - PROCESS | 1678 | |1;audio-beat-detection;172;118;127;212;150;170;139;125;167;124 09:06:15 INFO - PROCESS | 1678 | |2;audio-dft;194;247;217;194;193;195;194;194;200;197 09:06:15 INFO - PROCESS | 1678 | |3;audio-fft;67;78;72;143;58;85;80;94;155;57 09:06:15 INFO - PROCESS | 1678 | |4;audio-oscillator;74;64;120;105;115;123;132;77;82;123 09:06:15 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;76;131;136;89;92;87;92;88;91;88 09:06:15 INFO - PROCESS | 1678 | |6;imaging-darkroom;102;97;103;153;96;96;97;97;96;97 09:06:15 INFO - PROCESS | 1678 | |7;imaging-desaturate;89;100;90;123;146;146;154;91;93;93 09:06:15 INFO - PROCESS | 1678 | |8;json-parse-financial;63;68;65;66;66;67;65;81;65;61 09:06:15 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;66;71;77;69;76;74;70;69;69;68 09:06:15 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;81;84;82;82;81;83;81;81;87;85 09:06:15 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;148;119;144;150;151;143;126;130;147;144 09:06:15 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;168;172;158;218;233;189;169;169;167;155 09:06:15 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;68;92;97;99;78;68;67;73;70;71 09:06:15 INFO - PROCESS | 1678 | __end_tp_report 09:06:15 INFO - PROCESS | 1678 | __start_cc_report 09:06:15 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1096 09:06:15 INFO - PROCESS | 1678 | __end_cc_report 09:06:15 INFO - PROCESS | 1678 | __startTimestamp1464192375611__endTimestamp 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | ------- Summary: start ------- 09:06:15 INFO - PROCESS | 1678 | Number of tests: 14 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:140.90 Median:153.50 stddev:25.86 (16.9%) stddev-sans-first:25.82 09:06:15 INFO - PROCESS | 1678 | Values: 116.0 128.0 151.0 156.0 169.0 173.0 109.0 116.0 119.0 172.0 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:158.50 stddev:29.80 (18.8%) stddev-sans-first:30.56 09:06:15 INFO - PROCESS | 1678 | Values: 172.0 118.0 127.0 212.0 150.0 170.0 139.0 125.0 167.0 124.0 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:202.50 Median:196.00 stddev:17.20 (8.8%) stddev-sans-first:17.97 09:06:15 INFO - PROCESS | 1678 | Values: 194.0 247.0 217.0 194.0 193.0 195.0 194.0 194.0 200.0 197.0 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:88.90 Median:75.00 stddev:33.79 (45.0%) stddev-sans-first:34.89 09:06:15 INFO - PROCESS | 1678 | Values: 67.0 78.0 72.0 143.0 58.0 85.0 80.0 94.0 155.0 57.0 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:98.00 stddev:24.80 (25.3%) stddev-sans-first:24.22 09:06:15 INFO - PROCESS | 1678 | Values: 74.0 64.0 120.0 105.0 115.0 123.0 132.0 77.0 82.0 123.0 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:97.00 Median:88.50 stddev:19.80 (22.4%) stddev-sans-first:19.49 09:06:15 INFO - PROCESS | 1678 | Values: 76.0 131.0 136.0 89.0 92.0 87.0 92.0 88.0 91.0 88.0 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:96.50 stddev:17.61 (18.2%) stddev-sans-first:18.67 09:06:15 INFO - PROCESS | 1678 | Values: 102.0 97.0 103.0 153.0 96.0 96.0 97.0 97.0 96.0 97.0 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:112.50 Median:89.50 stddev:26.90 (30.1%) stddev-sans-first:27.16 09:06:15 INFO - PROCESS | 1678 | Values: 89.0 100.0 90.0 123.0 146.0 146.0 154.0 91.0 93.0 93.0 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:66.00 stddev:5.40 (8.2%) stddev-sans-first:5.56 09:06:15 INFO - PROCESS | 1678 | Values: 63.0 68.0 65.0 66.0 66.0 67.0 65.0 81.0 65.0 61.0 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:70.50 stddev:3.60 (5.1%) stddev-sans-first:3.36 09:06:15 INFO - PROCESS | 1678 | Values: 66.0 71.0 77.0 69.0 76.0 74.0 70.0 69.0 69.0 68.0 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.50 stddev:2.06 (2.5%) stddev-sans-first:2.09 09:06:15 INFO - PROCESS | 1678 | Values: 81.0 84.0 82.0 82.0 81.0 83.0 81.0 81.0 87.0 85.0 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:145.50 stddev:11.11 (7.6%) stddev-sans-first:11.42 09:06:15 INFO - PROCESS | 1678 | Values: 148.0 119.0 144.0 150.0 151.0 143.0 126.0 130.0 147.0 144.0 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.80 Median:170.50 stddev:25.95 (15.2%) stddev-sans-first:27.17 09:06:15 INFO - PROCESS | 1678 | Values: 168.0 172.0 158.0 218.0 233.0 189.0 169.0 169.0 167.0 155.0 09:06:15 INFO - PROCESS | 1678 | 09:06:15 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.30 Median:75.50 stddev:12.72 (16.8%) stddev-sans-first:12.93 09:06:15 INFO - PROCESS | 1678 | Values: 68.0 92.0 97.0 99.0 78.0 68.0 67.0 73.0 70.0 71.0 09:06:15 INFO - PROCESS | 1678 | -------- Summary: end -------- 09:06:15 INFO - PROCESS | 1678 | 09:06:16 INFO - TEST-INFO | 1678: exit 0 09:06:16 INFO - TEST-OK | kraken | took 60175ms 09:06:16 INFO - SUITE-END | took 1171s 09:06:16 INFO - Completed test suite (00:19:31) 09:06:16 INFO - javascript benchmark 09:06:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2782.65216847894, 2839.1766387747552, 3478.634743351948, 3495.1262184453894, 3497.8806781829794, 5187.533122019017, 5198.986197691452, 5705.828825135242, 5728.885422291557, 5737.713114344287, 5637.098064309711, 5665.461781130796, 5707.058335374669, 5719.799807006755, 5738.0, 4301.892452688677, 5213.6089793265655, 5273.0, 5284.894302113956, 5306.283651707028, 5127.487251274862, 5281.996420680059, 5311.9468805311835, 5364.651297665659, 5407.3781515125875, 5186.1442861927735, 5189.065968125736, 5206.843794686147, 5226.947730522684, 5329.573634109282, 5256.5794736421185, 5308.416074231832, 5316.441773613754, 5319.627626066177, 5349.491798279177, 5184.429712731597, 5267.209918512254, 5283.815066472655, 5296.682199068068, 5316.93661267748, 5383.596230282745, 5538.47384498472, 5627.2684551008515, 5634.4365563443735, 5658.943410565883, 6151.446369826737, 6165.969170154121, 6217.533684973645, 6219.160413344186, 6232.8130156095385, 5237.397699264595, 6228.470580000705, 6241.65670888101, 6246.718897649571, 6249.343818898996, 4244.469441319835, 5700.287464067033, 5882.941170588325, 5903.557233207526, 5915.319738230116, 6249.312575616678, 6275.309715931244, 6343.333949935282, 6367.363263673688, 6387.904181437282, 6135.202423684892, 6161.260648722182, 6205.751769929152, 6218.9378106219265, 6237.313895471494, 6170.167027451326, 6173.8456538586, 6207.720652570645, 6231.626102433868, 6242.15730876335, 6175.752969881154, 6218.440340369298, 6226.937730622726, 6238.937610623836, 6255.0, 6083.148359229712, 6225.159603453566, 6235.0, 6239.656818874914, 6258.249010118815, 4944.3572335596145, 4996.950030499721, 5004.574611158092, 5007.37407824022, 5039.118154322979, 4441.489228738672, 4451.399061126771, 4482.708623939434, 4489.0, 4492.842750503717, 5638.0, 5734.4552267535355, 5769.826905192851, 5785.652860828363, 5839.007368747239, 6132.630864714964, 6174.845628859314, 6176.320604733476, 6246.219222597176, 6281.937180628227, 5820.679862607512, 5829.300483941869, 5841.474267315962, 5846.561507886926, 5850.912236316459, 5322.3879253885525, 5400.108982017923, 5469.206964990054, 5469.343678758574, 5476.890462190734, 6450.451711604473, 6470.482361410982, 6502.772402965874, 6507.446867016357, 6510.609363438209, 6243.001119820807, 6246.3753624637175, 6251.124842521959, 6257.56197066201, 6257.937420625735, 5304.575633949197, 6391.753608046386, 6404.359564043559, 6456.870862582816, 6482.643454610042, 6174.598651087665, 6175.96912015437, 6191.442770150528, 6200.968995154995, 6213.068039794067, 6229.283632382334, 6234.597215626629, 6235.688215589294, 6255.37446255389, 6271.341509141657, 5774.0, 6053.788117416046, 6116.0010150213275, 6166.1983942087245, 6180.845478863064, 6101.359357267423, 6133.926562851572, 6146.754129834757, 6158.476529494864, 6168.784092556739, 5872.735726892215, 5970.044792833126, 6017.729202185825, 6074.787382441594, 6088.695565221809, 6044.667543285162, 6093.29927058394, 6141.359215537183, 6158.168647232566, 6175.475084617858, 5973.880522389441, 6052.2132122825515, 6052.273727152769, 6077.756889724538, 6078.665673388006], "value": 5699.320752269635, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.5660310434578, 576.8442520519458, 597.4145337569182, 599.989018503821, 606.6238931862246, 34987.0, 35113.0, 40397.394039089435, 41480.58519414805, 41515.79242103789, 37012.0, 43403.0, 43471.13057738851, 43536.78231608838, 43627.127457450835, 9669.854952175705, 9779.804403911918, 9790.657326993522, 9853.802923941517, 9879.110880020797, 9768.706938791813, 9818.067283608081, 9830.508474576278, 9848.310618256724, 9925.255605829556, 9840.655577054804, 9841.50792460374, 9853.0, 9911.553980070878, 9957.45234012129, 9798.90201097987, 9866.654667086654, 9918.958509356522, 9939.5030248488, 9940.801183976353, 9655.324127311022, 9662.468564228964, 9710.320277580573, 9788.755281117958, 9802.509874506246, 39028.609713902784, 39357.819265422084, 39441.40837887434, 39586.802065989774, 39834.0, 3124.297033167542, 3308.106811160997, 3309.271960168759, 3424.520567120605, 3439.914002149941, 28954.565681514796, 29128.271793205127, 29402.41195176106, 29759.553606695918, 29781.255468613243, 2734.6308248386413, 2765.778737700979, 2792.0925699147856, 2794.636697229347, 2816.380396312808, 467851.0, 468698.0, 471784.0, 473965.0, 475077.0, 63539.0, 63725.681371592844, 64140.679296603215, 64167.0, 64205.715885682024, 67279.3272067273, 70298.0, 71478.64260678767, 71603.0, 71704.64147679228, 17473.126343682765, 17715.379961701277, 17771.378001769877, 17854.821451785574, 17927.103644817707, 13392.866071339162, 13404.061715680004, 13497.662558436117, 13508.189508629514, 13519.121257118255, 19809.30667426662, 20124.798752012586, 20169.39491815248, 20205.37330147101, 20238.797612023987, 8555.315574754004, 8631.741047768577, 8669.479831210148, 8670.263027642595, 8772.561371931379, 965.666844938495, 994.721477986165, 1047.2930771729052, 1053.757635743783, 1067.2902519824386, 30061.098167055025, 30459.390812183632, 30471.695283046887, 30948.845255773576, 30991.380172396424, 1106.2035334559105, 1138.4364739454024, 1169.7718944805852, 1194.4923407551755, 1204.2232759869835, 13329.200247985153, 15317.0, 15749.291281892343, 15837.524874253791, 16198.0, 624954.0, 628609.0, 631996.0, 635535.0, 637456.0, 59415.70292148511, 61371.079433808525, 61388.38611613827, 61463.6926815372, 61473.38526614677, 1498.4380857178558, 1515.6892836968395, 1516.8634822865995, 1517.3475405575489, 1524.6798172383924, 30003.0, 30619.423044256244, 30642.23394415068, 30695.2326191847, 30733.53899691551, 53203.40389788312, 53371.4662853382, 53549.73225133849, 54319.0, 54392.45607544032, 568649.0, 568923.0, 573686.0, 573818.0, 574523.0, 27400.040998564953, 27764.861175693994, 27788.027419040238, 27839.30401739973, 28164.85917570481, 45175.870603235184, 45241.0, 47838.04323913572, 48171.0, 48253.75873120612, 30068.54897176588, 38928.42068674362, 38954.831355059396, 39079.609203907596, 40559.797201013804, 38094.23811523809, 38273.61726382701, 38519.80740096282, 38550.036249093995, 39227.80386098166, 37849.4322585156, 37948.0, 38878.22243555057, 39477.01307467336, 39545.20909581735, 30111.849440752656, 31878.52182217222, 32365.0, 32475.67524324821, 33594.32811343808, 24947.87526062358, 25160.993560257386, 25176.622350665122, 25312.873435632704, 25574.360640984123], "value": 20433.57845198978, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.70891160336924, 404.2400287459577, 405.93505039193735, 412.6121445840909, 413.7600191888705, 14901.552953411388, 16071.758923616155, 19587.314443994463, 20219.696704549424, 20304.89847550762, 18476.16857241424, 20293.79706202941, 21186.728796272197, 21396.8930155349, 22172.667409988822, 5748.511376533, 5769.855753606152, 6040.063790112539, 6060.969635162033, 6076.0, 5836.007878660638, 5923.992921203384, 5997.340292567836, 6018.9097163542365, 6037.849053773669, 5202.739863006835, 5307.52232299093, 5680.829575112753, 5825.213596164527, 5996.520278377741, 5834.27071616048, 5906.586538942276, 5971.820845374646, 5994.310654274771, 5995.6702381369005, 5164.793408263702, 5190.636655434121, 5203.687778733288, 5253.6322457428, 5283.735813209324, 26161.869190653924, 26200.60699089515, 26626.866865665546, 27144.728552714616, 27643.723562764317, 2094.895255237247, 2127.7553081395527, 2133.6052830226304, 2147.8174355179826, 2296.517731276434, 14711.63220919475, 14790.556283311518, 15120.319585618563, 15282.541523754306, 15567.0, 1689.0794516988271, 1716.3048965169125, 1764.7617571627795, 1781.5189898727401, 1796.97304540432, 108504.0, 110638.44680776545, 113363.0, 113884.29173562404, 114466.42766786112, 11527.308361498337, 11895.464704088337, 11995.340256285988, 12015.459304331325, 12096.879031209752, 15340.539783806504, 15377.231138443032, 15439.922800385926, 15450.38198472071, 15475.303611337516, 7701.614919254127, 8900.198982091642, 9057.456552606733, 9079.636814527477, 9131.0, 8912.821743565222, 9090.999990001095, 9091.727248182566, 9152.496612686233, 9184.8622270666, 4658.231391820312, 4735.573798358096, 4764.928526072112, 4787.329773831666, 4812.0, 1665.6751933372875, 1953.238237087537, 1993.312307253995, 1996.1316827180224, 2005.1377907499916, 786.8032991752062, 865.4201684871151, 947.4126041853957, 955.2310390135868, 1005.7535903703639, 20711.0, 20909.581808363746, 21881.562368752537, 22083.889580551993, 22175.889120554293, 818.2635627934907, 953.9475328856979, 959.3476436023572, 1018.3126389686931, 1073.2058276875057, 10876.293040952312, 11033.282836615594, 11065.557377704963, 11105.66682999495, 11201.551937922392, 584624.0, 621249.0, 623531.0, 630571.0, 634763.0, 116995.0751231226, 126396.36801815932, 134310.0, 135463.32268338595, 135595.0, 927.4806108579218, 942.3874481587023, 1007.2294694558668, 1071.328727185593, 1075.833245846895, 13367.26480043568, 15628.531144065697, 15818.367265309258, 18065.458036258933, 18998.620027599096, 53489.46510534845, 56276.0, 56912.43087569237, 56933.861322774144, 58712.412875870694, 79667.20332796598, 80426.59786701029, 81749.18250817416, 82756.0, 83057.58471207606, 6750.797476075725, 8111.0, 8359.916400835913, 8489.490630562186, 8583.141685831368, 10527.631532896312, 12605.621831345074, 12728.490860365482, 12749.553765618159, 12875.80686289725, 9227.76930576741, 11004.0, 11027.558897644325, 11150.665480035612, 11188.04901583342, 9255.953720231355, 10548.525316360628, 10705.518251678848, 10840.566377344818, 10946.014858662758, 9645.71062868115, 11217.831732523855, 11252.70593881714, 11262.04272636835, 11708.941455292668, 7063.1524217094275, 8278.503289802631, 8532.274756645755, 8593.69922052725, 8629.69796057135, 10557.736056598647, 11386.316820990767, 11421.37182454973, 11555.653330400102, 11668.183227174017], "value": 9678.62801656167, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1611.0897343001204, 1635.0353291557979, 1884.4252502986583, 1941.737865388173, 1993.7208790769305, 8001.239882211181, 8649.567521623925, 8816.559172041396, 9029.683961061364, 9041.909580904188, 8606.397552171351, 8626.827463450727, 8718.302535797136, 8723.520206388646, 8726.0, 2427.029188324671, 2441.2676197140877, 2449.3876530867283, 2451.5464639041747, 2456.0, 1964.7936966618443, 2434.184548176363, 2436.0134145670945, 2436.6954130733657, 2463.4949835283815, 2426.8665223412704, 2434.330559096245, 2451.963220551693, 2460.9507809843794, 2480.900763969439, 2457.8156638252026, 2460.753924607543, 2468.4322605800767, 2474.7030356357354, 2479.690038745157, 2288.096202000217, 2294.931152065424, 2330.34750269923, 2331.1491305673476, 2350.0129945422964, 8839.89501312336, 8858.512781796999, 8865.423747456394, 8879.644814207424, 8882.067382924764, 4487.304467807495, 5437.075697131497, 5466.01611709892, 5482.890342193174, 5488.121900495941, 3107.6115485564305, 3441.8107004114763, 3535.292941411728, 3554.8578056877695, 3670.1925576373155, 1056.1234175634206, 1070.293606219899, 1074.3285446595878, 1075.0432115417207, 1078.8435676826894, 12130.696732581668, 12352.25886446816, 12362.938185309196, 12373.752524949541, 12388.752224955451, 4781.091592597395, 4817.2774083887, 4901.583365413909, 4931.0630980113665, 4973.1297023020825, 10268.178545716324, 10458.895411045944, 10462.633807816843, 10489.265751397481, 10508.579656813794, 5438.374586922555, 5469.835904922858, 5489.39616642169, 5503.972480137573, 5504.752286147133, 4399.670024748157, 4773.976130119397, 4944.9258261126115, 4958.801647934042, 4998.025385049953, 4135.338345864708, 4158.126793373365, 4193.182329445729, 4238.682098842537, 4243.8090285937205, 1372.9107608005447, 1392.373431955624, 1394.8953828462907, 1396.0716123777777, 1407.422956587794, 820.2863508747428, 820.8727647214691, 876.9035406105323, 932.9253659707207, 966.4201479112477, 5185.559227465632, 5973.133895585116, 6037.909431358533, 6080.604760690541, 6227.034809604518, 978.9412635241908, 1000.7632940378248, 1003.4882210072915, 1012.2661070723666, 1047.4972013433442, 3519.5671883592813, 4112.280350938574, 4150.937735933903, 4152.148809494047, 4168.541460439349, 10863.293885897392, 11120.443977801078, 11177.385243811506, 11209.439528023566, 11223.494942727597, 10566.207534434949, 10750.516226769814, 10859.728506787236, 10972.725681857857, 10998.890011099787, 8001.8799718004275, 8459.407841451162, 8497.532635705096, 8528.40301178924, 8572.52851093196, 5965.254343207099, 5998.25021872266, 6036.396360364104, 6092.360302168208, 6110.633361998294, 9265.0, 9450.480223587494, 9583.0, 9630.951845241008, 9676.9032309676, 9442.244620430487, 9767.462789546644, 9778.973207813076, 9785.07041831025, 9903.405795652285, 7355.852882942204, 8071.959640201761, 8191.672333106609, 8272.917270827214, 8307.003159620885, 8204.261616454547, 8343.833123337621, 8361.0, 8415.074341822517, 8434.915650843413, 6898.793036208721, 7067.681954312171, 7387.741429049957, 7512.32389084985, 7637.770866874002, 7254.093238345207, 7254.927450725636, 7277.781666550012, 7295.744648937261, 7342.889856652261, 6915.481338899502, 6926.549774264657, 6940.0, 6941.167059952838, 6993.0, 4732.858014259577, 4739.691920025188, 4850.46644869057, 4858.951410485991, 4859.611231101574, 4932.0, 4936.111499930047, 4959.900801984012, 5043.167877300204, 5189.584833213258], "value": 4678.433922922946, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.94421004219237, 314.28186593633546, 327.2489636284726, 330.2750462734296, 335.163766402825, 4848.927266091011, 6296.803607314607, 6663.400293973541, 6768.458523318135, 6793.184817821868, 5780.4797568218855, 6662.700178491968, 6671.699773510191, 6680.46556275498, 6702.229243636971, 4777.140114779339, 4865.756712164378, 4987.700737955734, 5007.624428167884, 5018.071656743496, 4903.877403064934, 4925.38432695913, 4930.063287975273, 4939.901201975958, 4959.156943319645, 4870.464248932614, 4905.730184839832, 4906.31311616374, 4917.434495033063, 4924.581410580105, 4895.314655948152, 4905.484924082955, 4922.409310882681, 4926.0394223126505, 4950.8762280943265, 4259.51015633203, 4263.658907287409, 4271.188474189925, 4277.721948073366, 4283.378910058055, 6236.6258024518675, 6353.5234857385885, 6391.968040159816, 6398.392152745481, 6565.080888675589, 4448.777561121931, 4818.638602104821, 5879.176915231871, 5879.441453061952, 5883.911741323884, 7219.8917016244795, 7223.711051557932, 7237.638118094074, 7246.565206087652, 7262.854742905165, 4816.662833601649, 4819.397575303087, 4822.493638167977, 4823.276508523714, 4844.346013288232, 6213.906791398133, 6229.314775374705, 7644.5093206824695, 7679.769606911802, 7691.692332306701, 4021.738586991836, 4727.220008698595, 4903.239997800347, 4914.115459217375, 4933.161362568372, 4966.875828104254, 5018.799248030111, 5021.196608542616, 5022.472640372781, 5036.370453693288, 5868.589198756132, 5934.406559344117, 5935.0, 5939.46544810969, 5954.4045595440975, 7256.419486441072, 7256.818579535554, 7285.562866228043, 7295.088113985752, 7306.707731690779, 1725.1374312843577, 1754.0703427183614, 1756.631107467446, 1757.4903278049478, 1768.2926829268395, 1020.9489525523694, 1067.3382502848128, 1069.8769641491172, 1129.4014172488594, 1144.6852115668091, 6412.294647588761, 6486.740530378732, 6490.383413575702, 6533.607983521004, 6588.670566471657, 7290.927090729131, 7380.557166570023, 7389.593572353465, 7402.519496100801, 7407.407407407394, 6446.419822216023, 6585.111010013587, 6687.966560167265, 6701.932980670228, 6785.287544807823, 3387.847546860348, 4016.6786657067364, 4032.3145065338963, 4036.899077523027, 4061.6750659947725, 7916.08964969036, 7975.481593696391, 8012.839743205103, 8019.318357939524, 8032.558209298428, 7566.843449616943, 7841.921580784233, 7872.33085187754, 7928.246816552418, 7930.6431210595665, 7905.249001344748, 7944.6822127114265, 8025.9598702006115, 8047.034355877332, 8053.677852885936, 6077.908831367445, 7650.2349765023055, 7654.617269136632, 7677.654505547375, 7693.4614576979075, 7465.0, 7474.0, 7475.392790550058, 7494.925050749423, 7525.548467091992, 7704.730334438268, 7879.64541595641, 8023.0, 8024.277814996678, 8032.799180020546, 4704.153252414461, 4742.051589682008, 4776.140294746979, 4786.832460863853, 4799.304100905419, 6104.481119104926, 7533.284337987882, 7610.353119984863, 7611.314981651678, 7622.123455802654, 6580.8354791130605, 7318.451116166202, 7324.523905946096, 7343.8898416522725, 7356.154042284991, 5817.94182058174, 7051.365377116084, 7171.533850299714, 7269.873169658711, 7288.927110728825, 7061.752838650623, 7108.964455177691, 7109.111361079865, 7160.391366733677, 7354.043974283309, 5840.94159058421, 7267.60028198433, 7298.233685463162, 7311.890321645286, 7318.890216646648, 6895.965520172367, 7056.682449289897, 7083.929160708533, 7114.466415018997, 7185.353318201387], "value": 5261.1013431747415, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.9253182149963, 718.8749606865259, 738.3723834740468, 742.1873049011338, 765.288281897835, 14813.259337033145, 14816.6295842604, 14921.328540215676, 14929.253537323117, 15023.39906403744, 13430.194188348705, 13864.0, 13864.514741984032, 13866.930665346685, 13901.165930044204, 721.4372789224414, 891.656712165816, 901.729481155654, 901.9774505637379, 928.4382948316239, 878.6134100995573, 904.5251243097393, 907.587047893207, 910.3809409601469, 910.9362344635878, 926.8702381666573, 960.8414611589079, 962.0523784072683, 962.7593101724569, 963.3016063354082, 933.5658918602883, 943.481085403029, 957.4686049242667, 958.9952050239774, 960.3181740963959, 687.9380855722959, 709.9680514376865, 714.957102573842, 715.7065603102754, 718.3642476408364, 14598.41606335756, 14921.477748278867, 14949.103053816805, 14959.700805983928, 14981.925090374478, 12511.74976500465, 12532.749345013048, 12582.056345774103, 12738.172018818746, 12738.745225095447, 9920.40477571348, 9987.0, 10054.296199266055, 10258.487075646188, 10298.845517317246, 3442.7934323940394, 3451.0854623524788, 3490.5462289902152, 3567.161716996504, 3728.4780130781714, 79982.60008699978, 80167.5991620044, 81436.0, 81438.0, 81482.59258703727, 9254.953725231331, 9350.95324523373, 9415.62337506492, 9421.576029078571, 9579.994100619335, 21612.45968850791, 21749.34751957444, 21842.563148736936, 21904.89047554752, 22027.0, 6411.871762564816, 6415.326390728999, 7296.416286697052, 7330.816729581697, 7504.849903001909, 4109.856155034619, 4125.154343359604, 4127.504699436087, 4133.318002529549, 4134.4005119258145, 2991.7457016153435, 3276.39386713454, 3441.6558344165883, 3442.7762195457217, 3526.100844284691, 547.5811004581499, 624.9906251406233, 626.139058794158, 638.9105525226472, 648.5849056603778, 519.1226826663003, 555.8082461550758, 578.3984655957756, 581.4505292498549, 605.9121427393003, 8125.553094579855, 8195.508269503849, 8281.171882811792, 8501.95749021251, 8519.233269005696, 512.3723438787456, 513.2122192434595, 517.3119750731518, 586.4545972245852, 588.5115354255958, 3204.423203823334, 3770.4155855842387, 3854.5181852268465, 3856.8842934712, 3872.1481274119647, 88862.0, 89787.0, 89915.55042224878, 89937.0, 91479.54260228656, 53478.0, 63041.84790760444, 68124.0, 77686.0, 79362.0, 54546.454535454934, 59838.70080649569, 64609.0, 65510.672446637465, 66372.6725465488, 6596.0, 7010.404115650227, 7678.155402905788, 7696.692132314644, 7802.726904558313, 48459.061637534105, 48781.5121848777, 49525.504744953534, 49955.50044499509, 50117.24824127714, 61109.69445152746, 62337.68831155815, 65825.67087164533, 66947.33052669605, 67542.0, 10153.84769228477, 10368.948155259175, 10369.585216591251, 10371.377717336984, 10378.377297362182, 10829.783404331713, 10863.511141998788, 10891.727706807393, 10903.890961090288, 10988.890111098786, 8537.231649151607, 10170.0, 10241.590336386462, 10244.334118282288, 10799.946000269949, 10225.488725563544, 10387.792244154924, 10488.0, 10626.681199564026, 10650.946745266225, 10039.548220330249, 10137.138343240907, 10194.43930583825, 10196.13332866685, 10310.226732994905, 8765.956170219108, 8879.91120088791, 9054.818903622023, 9137.862932056158, 9224.262059035127, 8810.911890881265, 8837.0, 8870.866936996079, 8920.776980575538, 8940.86588701183], "value": 6649.036441008386, "unit": "score"}], "name": "dromaeo_css", "value": 7544.998238347686, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 128.0, 151.0, 156.0, 169.0, 173.0, 109.0, 116.0, 119.0, 172.0], "value": 140.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 118.0, 127.0, 212.0, 150.0, 170.0, 139.0, 125.0, 167.0, 124.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 247.0, 217.0, 194.0, 193.0, 195.0, 194.0, 194.0, 200.0, 197.0], "value": 202.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 78.0, 72.0, 143.0, 58.0, 85.0, 80.0, 94.0, 155.0, 57.0], "value": 88.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 64.0, 120.0, 105.0, 115.0, 123.0, 132.0, 77.0, 82.0, 123.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 131.0, 136.0, 89.0, 92.0, 87.0, 92.0, 88.0, 91.0, 88.0], "value": 97.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 97.0, 103.0, 153.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0], "value": 103.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 100.0, 90.0, 123.0, 146.0, 146.0, 154.0, 91.0, 93.0, 93.0], "value": 112.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 68.0, 65.0, 66.0, 66.0, 67.0, 65.0, 81.0, 65.0, 61.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 77.0, 69.0, 76.0, 74.0, 70.0, 69.0, 69.0, 68.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 82.0, 82.0, 81.0, 83.0, 81.0, 81.0, 87.0, 85.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 144.0, 150.0, 151.0, 143.0, 126.0, 130.0, 147.0, 144.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 172.0, 158.0, 218.0, 233.0, 189.0, 169.0, 169.0, 167.0, 155.0], "value": 179.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 92.0, 97.0, 99.0, 78.0, 68.0, 67.0, 73.0, 70.0, 71.0], "value": 78.3, "unit": "score"}], "name": "kraken", "value": 1615.7, "alertThreshold": 2.0}]} 09:06:16 INFO - Return code: 0 09:06:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:06:16 ERROR - # TBPL SUCCESS # 09:06:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:06:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:06:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:06:16 INFO - 2016-05-25 09:06:16.920 screenresolution[1683:10299] starting screenresolution argv=screenresolution get 09:06:16 INFO - 2016-05-25 09:06:16.922 screenresolution[1683:10299] Display 0: 1600x1200x32@60 09:06:16 INFO - 2016-05-25 09:06:16.928 screenresolution[1684:10302] starting screenresolution argv=screenresolution list 09:06:16 INFO - Available Modes on Display 0 09:06:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:06:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:06:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:06:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:06:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:06:17 INFO - Intel Iris: 09:06:17 INFO - Chipset Model: Intel Iris 09:06:17 INFO - Type: GPU 09:06:17 INFO - Bus: Built-In 09:06:17 INFO - VRAM (Dynamic, Max): 1536 MB 09:06:17 INFO - Vendor: Intel (0x8086) 09:06:17 INFO - Device ID: 0x0a2e 09:06:17 INFO - Revision ID: 0x0009 09:06:17 INFO - Displays: 09:06:17 INFO - Display: 09:06:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:06:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:06:17 INFO - Display Serial Number: 1600x1200 60 09:06:17 INFO - Main Display: Yes 09:06:17 INFO - Mirror: Off 09:06:17 INFO - Online: Yes 09:06:17 INFO - Rotation: Supported 09:06:17 INFO - Return code: 0 09:06:17 INFO - Running post-action listener: _resource_record_post_action 09:06:17 INFO - Running post-run listener: _resource_record_post_run 09:06:18 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 37590528; Write bytes: 655095808; Read time: 393; Write time: 1840 09:06:18 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 349020672; Write bytes: 346355712; Read time: 27447; Write time: 600 09:06:18 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 35776000; Write bytes: 297947136; Read time: 373; Write time: 1204 09:06:18 INFO - Running post-run listener: _upload_blobber_files 09:06:18 INFO - Blob upload gear active. 09:06:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:06:18 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 09:06:18 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:06:18 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:06:18 INFO - (blobuploader) - INFO - Open directory for files ... 09:06:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:06:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:06:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:19 INFO - (blobuploader) - INFO - Done attempting. 09:06:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:06:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:06:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:20 INFO - (blobuploader) - INFO - Done attempting. 09:06:20 INFO - (blobuploader) - INFO - Iteration through files over. 09:06:20 INFO - Return code: 0 09:06:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:06:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:06:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3a3aae7e289ac8aaa7902a49a61d42c8b5c0220049192f3a85ceeaa6802b7d4a1af3cc0525ad4dcdd8044c605d52202fd115256e019c0d367ca97b1483a1b56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8007331c6ed7673edd02f44633df859b52eecf907d9b21673908433e8a2100e18f9f45bbf33a43610280c2812f7dc5db0d652e7332ab040cea8074a0c23aa07b"} 09:06:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:06:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:06:20 INFO - Contents: 09:06:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3a3aae7e289ac8aaa7902a49a61d42c8b5c0220049192f3a85ceeaa6802b7d4a1af3cc0525ad4dcdd8044c605d52202fd115256e019c0d367ca97b1483a1b56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8007331c6ed7673edd02f44633df859b52eecf907d9b21673908433e8a2100e18f9f45bbf33a43610280c2812f7dc5db0d652e7332ab040cea8074a0c23aa07b"} 09:06:20 INFO - Running post-run listener: copy_logs_to_upload_dir 09:06:20 INFO - Copying logs to upload dir... 09:06:20 INFO - mkdir: /builds/slave/test/build/upload/logs 09:06:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.602857 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-25 09:06:20.583884) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 09:06:20.587878) ========= 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.v9KteHxHUi/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.5dxQRdO0l6/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3a3aae7e289ac8aaa7902a49a61d42c8b5c0220049192f3a85ceeaa6802b7d4a1af3cc0525ad4dcdd8044c605d52202fd115256e019c0d367ca97b1483a1b56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8007331c6ed7673edd02f44633df859b52eecf907d9b21673908433e8a2100e18f9f45bbf33a43610280c2812f7dc5db0d652e7332ab040cea8074a0c23aa07b"} build_url:https://queue.taskcluster.net/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010704 build_url: 'https://queue.taskcluster.net/v1/task/MopxZW-_RhqYSZ2B79fydw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3a3aae7e289ac8aaa7902a49a61d42c8b5c0220049192f3a85ceeaa6802b7d4a1af3cc0525ad4dcdd8044c605d52202fd115256e019c0d367ca97b1483a1b56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8007331c6ed7673edd02f44633df859b52eecf907d9b21673908433e8a2100e18f9f45bbf33a43610280c2812f7dc5db0d652e7332ab040cea8074a0c23aa07b"}' ========= master_lag: 0.22 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 09:06:20.821277) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:06:20.821614) ========= 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.v9KteHxHUi/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.5dxQRdO0l6/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.005117 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:06:20.845735) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 09:06:20.846034) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 09:06:20.847182) ========= ========= Total master_lag: 0.35 =========