builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0073 starttime: 1463034121.87 results: success (0) buildid: 20160511211918 builduid: b5b007d81d4a4000989fa67bcd6e7e31 revision: 2fb177e17d81e069a02797c6234e8ed085cbc55c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 23:22:01.873029) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 23:22:01.873438) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 mins, 1 secs) (at 2016-05-11 23:22:01.873724) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 mins, 1 secs) (at 2016-05-11 23:23:03.384549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:23:03.385281) ========= 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.fp6ou6qQxq/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.xI3CIXPRnc/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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-11 23:23:03-- 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-11 23:23:03 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.364542 ========= master_lag: 0.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:23:04.028019) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:23:04.028369) ========= 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.fp6ou6qQxq/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.xI3CIXPRnc/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.020269 ========= master_lag: 0.33 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:23:04.381806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-11 23:23:04.382124) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2fb177e17d81e069a02797c6234e8ed085cbc55c --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 2fb177e17d81e069a02797c6234e8ed085cbc55c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fp6ou6qQxq/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.xI3CIXPRnc/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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-11 23:23:04,492 truncating revision to first 12 chars 2016-05-11 23:23:04,492 Setting DEBUG logging. 2016-05-11 23:23:04,492 attempt 1/10 2016-05-11 23:23:04,492 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2fb177e17d81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 23:23:05,776 unpacking tar archive at: mozilla-aurora-2fb177e17d81/testing/mozharness/ program finished with exit code 0 elapsedTime=1.525525 ========= master_lag: 1.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-11 23:23:07.091107) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 23:23:07.091367) ========= script_repo_revision: 2fb177e17d81e069a02797c6234e8ed085cbc55c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 23:23:07.091724) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-05-11 23:23:07.091980) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-05-11 23:23:13.018715) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-11 23:23:13.018974) ========= /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.fp6ou6qQxq/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.xI3CIXPRnc/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:23:13 INFO - MultiFileLogger online at 20160511 23:23:13 in /builds/slave/test 23:23:13 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 23:23:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:23:13 INFO - {'append_to_log': False, 23:23:13 INFO - 'base_work_dir': '/builds/slave/test', 23:23:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:23:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:23:13 INFO - 'branch': 'Mozilla-Aurora', 23:23:13 INFO - 'buildbot_json_path': 'buildprops.json', 23:23:13 INFO - 'config_files': ('talos/mac_config.py',), 23:23:13 INFO - 'default_actions': ('clobber', 23:23:13 INFO - 'read-buildbot-config', 23:23:13 INFO - 'download-and-extract', 23:23:13 INFO - 'populate-webroot', 23:23:13 INFO - 'create-virtualenv', 23:23:13 INFO - 'install', 23:23:13 INFO - 'run-tests'), 23:23:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:23:13 INFO - 'download_minidump_stackwalk': True, 23:23:13 INFO - 'download_symbols': 'ondemand', 23:23:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:23:13 INFO - 'tooltool.py': '/tools/tooltool.py', 23:23:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:23:13 INFO - '/tools/misc-python/virtualenv.py')}, 23:23:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:23:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:23:13 INFO - 'installer_path': 'installer.exe', 23:23:13 INFO - 'log_level': 'info', 23:23:13 INFO - 'log_name': 'talos', 23:23:13 INFO - 'log_to_console': True, 23:23:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:23:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:23:13 INFO - 'opt_config_files': (), 23:23:13 INFO - 'pip_index': False, 23:23:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:23:13 INFO - 'cmd': ('bash', 23:23:13 INFO - '-c', 23:23:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:23:13 INFO - 'enabled': True, 23:23:13 INFO - 'halt_on_failure': False, 23:23:13 INFO - 'name': 'check_screen_resolution'},), 23:23:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:23:13 INFO - 'cmd': ('bash', 23:23:13 INFO - '-c', 23:23:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:23:13 INFO - 'enabled': True, 23:23:13 INFO - 'halt_on_failure': False, 23:23:13 INFO - 'name': 'check_screen_resolution'},), 23:23:13 INFO - 'run_cmd_checks_enabled': True, 23:23:13 INFO - 'sps_profile': False, 23:23:13 INFO - 'sps_profile_interval': 0, 23:23:13 INFO - 'suite': 'dromaeojs-e10s', 23:23:13 INFO - 'system_bits': '32', 23:23:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:23:13 INFO - 'title': 't-yosemite-r7-0073', 23:23:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:23:13 INFO - 'use_talos_json': True, 23:23:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:23:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:23:13 INFO - 'work_dir': 'build'} 23:23:13 INFO - ##### 23:23:13 INFO - ##### Running clobber step. 23:23:13 INFO - ##### 23:23:13 INFO - Running pre-action listener: _resource_record_pre_action 23:23:13 INFO - Running main action method: clobber 23:23:13 INFO - rmtree: /builds/slave/test/build 23:23:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:23:15 INFO - Running post-action listener: _resource_record_post_action 23:23:15 INFO - ##### 23:23:15 INFO - ##### Running read-buildbot-config step. 23:23:15 INFO - ##### 23:23:15 INFO - Running pre-action listener: _resource_record_pre_action 23:23:15 INFO - Running main action method: read_buildbot_config 23:23:15 INFO - Using buildbot properties: 23:23:15 INFO - { 23:23:15 INFO - "project": "", 23:23:15 INFO - "product": "firefox", 23:23:15 INFO - "script_repo_revision": "production", 23:23:15 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 23:23:15 INFO - "repository": "", 23:23:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 23:23:15 INFO - "buildid": "20160511211918", 23:23:15 INFO - "pgo_build": "False", 23:23:15 INFO - "basedir": "/builds/slave/test", 23:23:15 INFO - "buildnumber": 325, 23:23:15 INFO - "slavename": "t-yosemite-r7-0073", 23:23:15 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 23:23:15 INFO - "platform": "yosemite_r7", 23:23:15 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 23:23:15 INFO - "branch": "mozilla-aurora", 23:23:15 INFO - "repo_path": "releases/mozilla-aurora", 23:23:15 INFO - "revision": "2fb177e17d81e069a02797c6234e8ed085cbc55c", 23:23:15 INFO - "stage_platform": "macosx64", 23:23:15 INFO - "builduid": "b5b007d81d4a4000989fa67bcd6e7e31", 23:23:15 INFO - "slavebuilddir": "test" 23:23:15 INFO - } 23:23:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 23:23:15 INFO - Running post-action listener: _resource_record_post_action 23:23:15 INFO - ##### 23:23:15 INFO - ##### Running download-and-extract step. 23:23:15 INFO - ##### 23:23:15 INFO - Running pre-action listener: _resource_record_pre_action 23:23:15 INFO - Running main action method: download_and_extract 23:23:15 INFO - mkdir: /builds/slave/test/build/tests 23:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:15 INFO - https://queue.taskcluster.net/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 23:23:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 23:23:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 23:23:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/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 23:23:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/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 23:23:17 INFO - Downloaded 1199 bytes. 23:23:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 23:23:17 INFO - Using the following test package requirements: 23:23:17 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 23:23:17 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 23:23:17 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 23:23:17 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 23:23:17 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 23:23:17 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 23:23:17 INFO - u'jsshell-mac.zip'], 23:23:17 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 23:23:17 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 23:23:17 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 23:23:17 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 23:23:17 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 23:23:17 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 23:23:17 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 23:23:17 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 23:23:17 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 23:23:17 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 23:23:17 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 23:23:17 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 23:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:17 INFO - https://queue.taskcluster.net/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:23:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 23:23:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 23:23:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/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 23:23:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/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 23:23:18 INFO - Downloaded 18089390 bytes. 23:23:18 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'] 23:23:18 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 23:23:21 INFO - Return code: 0 23:23:21 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 23:23: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')]} 23:23:21 INFO - https://queue.taskcluster.net/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:23:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 23:23:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 23:23:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/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 23:23:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/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 23:23:22 INFO - Downloaded 18089390 bytes. 23:23: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'] 23:23: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 23:23:26 INFO - Return code: 0 23:23:26 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')]} 23:23:26 INFO - https://queue.taskcluster.net/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:23:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 23:23:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 23:23:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/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 23:23:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/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 23:23:26 INFO - Downloaded 10840145 bytes. 23:23:26 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'] 23:23:26 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 23:23:27 INFO - Return code: 0 23:23:27 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')]} 23:23:27 INFO - https://queue.taskcluster.net/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 23:23:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 23:23:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 23:23:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 23:23:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a5swiOwTRgGHPLsEeXd3Ag/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 23:23:33 INFO - Downloaded 114120375 bytes. 23:23:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 23:23:33 INFO - mkdir: /builds/slave/test/properties 23:23:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:23:33 INFO - Writing to file /builds/slave/test/properties/build_url 23:23:33 INFO - Contents: 23:23:33 INFO - build_url:https://queue.taskcluster.net/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 23:23:33 INFO - Running post-action listener: _resource_record_post_action 23:23:33 INFO - Running post-action listener: set_extra_try_arguments 23:23:33 INFO - ##### 23:23:33 INFO - ##### Running populate-webroot step. 23:23:33 INFO - ##### 23:23:33 INFO - Running pre-action listener: _resource_record_pre_action 23:23:33 INFO - Running main action method: populate_webroot 23:23:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:23:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:23:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:23:33 INFO - '--tppagecycles', 23:23:33 INFO - '7'], 23:23:33 INFO - 'tests': ['tsvgm']}}, 23:23:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:23:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:23:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:23:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:23:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:23:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:23:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:33 INFO - 'talos_options': ['--disable-e10s'], 23:23:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:23:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:23:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:33 INFO - 'talos_options': ['--disable-e10s'], 23:23:33 INFO - 'tests': ['damp', 'tps']}, 23:23:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:33 INFO - 'tests': ['damp', 'tps']}, 23:23:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:23:33 INFO - 'tests': ['dromaeo_dom']}, 23:23:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:23:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:23:33 INFO - 'tests': ['a11yr', 23:23:33 INFO - 'ts_paint', 23:23:33 INFO - 'tpaint', 23:23:33 INFO - 'sessionrestore', 23:23:33 INFO - 'sessionrestore_no_auto_restore', 23:23:33 INFO - 'tabpaint']}, 23:23:33 INFO - 'other-e10s': {'tests': ['a11yr', 23:23:33 INFO - 'ts_paint', 23:23:33 INFO - 'tpaint', 23:23:33 INFO - 'sessionrestore', 23:23:33 INFO - 'sessionrestore_no_auto_restore', 23:23:33 INFO - 'tabpaint']}, 23:23:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:23:33 INFO - 'ts_paint', 23:23:33 INFO - 'tpaint', 23:23:33 INFO - 'sessionrestore', 23:23:33 INFO - 'sessionrestore_no_auto_restore', 23:23:33 INFO - 'tabpaint']}, 23:23:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:23:33 INFO - 'ts_paint', 23:23:33 INFO - 'tpaint', 23:23:33 INFO - 'sessionrestore', 23:23:33 INFO - 'sessionrestore_no_auto_restore', 23:23:33 INFO - 'tabpaint']}, 23:23:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:23:33 INFO - 'tests': ['a11yr', 23:23:33 INFO - 'ts_paint', 23:23:33 INFO - 'tpaint', 23:23:33 INFO - 'sessionrestore', 23:23:33 INFO - 'sessionrestore_no_auto_restore', 23:23:33 INFO - 'tabpaint']}, 23:23:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:23:33 INFO - 'tests': ['a11yr', 23:23:33 INFO - 'ts_paint', 23:23:33 INFO - 'tpaint', 23:23:33 INFO - 'sessionrestore', 23:23:33 INFO - 'sessionrestore_no_auto_restore', 23:23:33 INFO - 'tabpaint']}, 23:23:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:23:33 INFO - 'tests': ['tsvgx', 23:23:33 INFO - 'tsvgr_opacity', 23:23:33 INFO - 'tart', 23:23:33 INFO - 'tscrollx', 23:23:33 INFO - 'cart']}, 23:23:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:23:33 INFO - 'tsvgr_opacity', 23:23:33 INFO - 'tart', 23:23:33 INFO - 'tscrollx', 23:23:33 INFO - 'cart']}, 23:23:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:33 INFO - 'talos_options': ['--disable-e10s'], 23:23:33 INFO - 'tests': ['tp5o']}, 23:23:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:33 INFO - 'tests': ['tp5o']}, 23:23:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:33 INFO - 'talos_options': ['--disable-e10s', 23:23:33 INFO - '--xperf_path', 23:23:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:23:33 INFO - 'tests': ['tp5n']}, 23:23:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:33 INFO - 'talos_options': ['--xperf_path', 23:23:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:23:33 INFO - 'tests': ['tp5n']}}, 23:23:33 INFO - 'talos.zip': {'path': '', 23:23:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:23:33 INFO - Running post-action listener: _resource_record_post_action 23:23:33 INFO - ##### 23:23:33 INFO - ##### Running create-virtualenv step. 23:23:33 INFO - ##### 23:23:33 INFO - Running pre-action listener: _resource_record_pre_action 23:23:33 INFO - Running main action method: create_virtualenv 23:23:33 INFO - Creating virtualenv /builds/slave/test/build/venv 23:23:33 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 23:23:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:23:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:23:34 INFO - Using real prefix '/tools/python27' 23:23:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:23:34 INFO - Installing distribute.............................................................................................................................................................................................done. 23:23:37 INFO - Installing pip.................done. 23:23:37 INFO - Return code: 0 23:23:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:23:37 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')]} 23:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:37 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')]} 23:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:37 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 0x10d9a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1c9d72be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d840e00>, '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 0x10d6a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d83bb20>, '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.fp6ou6qQxq/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.xI3CIXPRnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:23:37 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 23:23:37 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 23:23:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp6ou6qQxq/Render', 23:23:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:23:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:23:37 INFO - 'HOME': '/Users/cltbld', 23:23:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:23:37 INFO - 'LOGNAME': 'cltbld', 23:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:37 INFO - 'MOZ_NO_REMOTE': '1', 23:23:37 INFO - 'NO_EM_RESTART': '1', 23:23:37 INFO - 'PAGER': '/bin/cat', 23:23:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:37 INFO - 'PWD': '/builds/slave/test', 23:23:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:23:37 INFO - 'SHELL': '/bin/bash', 23:23:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xI3CIXPRnc/Listeners', 23:23:37 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:23:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:23:37 INFO - 'USER': 'cltbld', 23:23:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:23:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:37 INFO - 'XPC_FLAGS': '0x0', 23:23:37 INFO - 'XPC_SERVICE_NAME': '0', 23:23:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:37 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 23:23:37 INFO - Cleaning up... 23:23:37 INFO - Return code: 0 23:23:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:23:37 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')]} 23:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:37 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')]} 23:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:37 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 0x10d9a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1c9d72be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d840e00>, '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 0x10d6a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d83bb20>, '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.fp6ou6qQxq/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.xI3CIXPRnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:23:37 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 23:23:37 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 23:23:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp6ou6qQxq/Render', 23:23:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:23:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:23:37 INFO - 'HOME': '/Users/cltbld', 23:23:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:23:37 INFO - 'LOGNAME': 'cltbld', 23:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:37 INFO - 'MOZ_NO_REMOTE': '1', 23:23:37 INFO - 'NO_EM_RESTART': '1', 23:23:37 INFO - 'PAGER': '/bin/cat', 23:23:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:37 INFO - 'PWD': '/builds/slave/test', 23:23:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:23:37 INFO - 'SHELL': '/bin/bash', 23:23:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xI3CIXPRnc/Listeners', 23:23:37 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:23:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:23:37 INFO - 'USER': 'cltbld', 23:23:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:23:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:37 INFO - 'XPC_FLAGS': '0x0', 23:23:37 INFO - 'XPC_SERVICE_NAME': '0', 23:23:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:38 INFO - Downloading/unpacking psutil>=0.7.1 23:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:23:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:23:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:23:41 INFO - Installing collected packages: psutil 23:23:41 INFO - Running setup.py install for psutil 23:23:41 INFO - building 'psutil._psutil_osx' extension 23:23:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 23:23:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 23:23:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 23:23:41 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 23:23:41 INFO - building 'psutil._psutil_posix' extension 23:23:41 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 23:23:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:23:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:23:42 INFO - ^ 23:23:42 INFO - 1 warning generated. 23:23:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 23:23:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:23:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:23:42 INFO - Successfully installed psutil 23:23:42 INFO - Cleaning up... 23:23:42 INFO - Return code: 0 23:23:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1c9d72be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d840e00>, '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 0x10d6a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d83bb20>, '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.fp6ou6qQxq/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.xI3CIXPRnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:23:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:23:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp6ou6qQxq/Render', 23:23:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:23:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:23:42 INFO - 'HOME': '/Users/cltbld', 23:23:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:23:42 INFO - 'LOGNAME': 'cltbld', 23:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:42 INFO - 'MOZ_NO_REMOTE': '1', 23:23:42 INFO - 'NO_EM_RESTART': '1', 23:23:42 INFO - 'PAGER': '/bin/cat', 23:23:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:42 INFO - 'PWD': '/builds/slave/test', 23:23:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:23:42 INFO - 'SHELL': '/bin/bash', 23:23:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xI3CIXPRnc/Listeners', 23:23:42 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:23:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:23:42 INFO - 'USER': 'cltbld', 23:23:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:23:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:42 INFO - 'XPC_FLAGS': '0x0', 23:23:42 INFO - 'XPC_SERVICE_NAME': '0', 23:23:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:23:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:23:45 INFO - Installing collected packages: mozsystemmonitor 23:23:45 INFO - Running setup.py install for mozsystemmonitor 23:23:45 INFO - Successfully installed mozsystemmonitor 23:23:45 INFO - Cleaning up... 23:23:45 INFO - Return code: 0 23:23:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:23: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')]} 23:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23: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')]} 23:23:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1c9d72be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d840e00>, '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 0x10d6a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d83bb20>, '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.fp6ou6qQxq/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.xI3CIXPRnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:23:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:23:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp6ou6qQxq/Render', 23:23:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:23:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:23:45 INFO - 'HOME': '/Users/cltbld', 23:23:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:23:45 INFO - 'LOGNAME': 'cltbld', 23:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:45 INFO - 'MOZ_NO_REMOTE': '1', 23:23:45 INFO - 'NO_EM_RESTART': '1', 23:23:45 INFO - 'PAGER': '/bin/cat', 23:23:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:45 INFO - 'PWD': '/builds/slave/test', 23:23:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:23:45 INFO - 'SHELL': '/bin/bash', 23:23:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xI3CIXPRnc/Listeners', 23:23:45 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:23:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:23:45 INFO - 'USER': 'cltbld', 23:23:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:23:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:45 INFO - 'XPC_FLAGS': '0x0', 23:23:45 INFO - 'XPC_SERVICE_NAME': '0', 23:23:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:45 INFO - Downloading/unpacking blobuploader==1.2.4 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23:47 INFO - Downloading blobuploader-1.2.4.tar.gz 23:23:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:23:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:23:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23:49 INFO - Downloading docopt-0.6.1.tar.gz 23:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:23:49 INFO - Installing collected packages: blobuploader, requests, docopt 23:23:49 INFO - Running setup.py install for blobuploader 23:23:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:23:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:23:49 INFO - Running setup.py install for requests 23:23:49 INFO - Running setup.py install for docopt 23:23:49 INFO - Successfully installed blobuploader requests docopt 23:23:49 INFO - Cleaning up... 23:23:50 INFO - Return code: 0 23:23:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1c9d72be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d840e00>, '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 0x10d6a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d83bb20>, '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.fp6ou6qQxq/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.xI3CIXPRnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:23:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:23:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp6ou6qQxq/Render', 23:23:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:23:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:23:50 INFO - 'HOME': '/Users/cltbld', 23:23:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:23:50 INFO - 'LOGNAME': 'cltbld', 23:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:50 INFO - 'MOZ_NO_REMOTE': '1', 23:23:50 INFO - 'NO_EM_RESTART': '1', 23:23:50 INFO - 'PAGER': '/bin/cat', 23:23:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:50 INFO - 'PWD': '/builds/slave/test', 23:23:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:23:50 INFO - 'SHELL': '/bin/bash', 23:23:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xI3CIXPRnc/Listeners', 23:23:50 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:23:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:23:50 INFO - 'USER': 'cltbld', 23:23:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:23:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:50 INFO - 'XPC_FLAGS': '0x0', 23:23:50 INFO - 'XPC_SERVICE_NAME': '0', 23:23:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:23:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-CqoMFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:23:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-yX9BnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:23:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Waxv2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:23:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Rn9n1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:23:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-1b37HE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:23:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Ceuxeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:23:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-znaSG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:23:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ama70q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:23:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-L7vvTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:23:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-OZ4HRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:23:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-MPhH7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:23:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-s8Ch4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:23:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Kwjct0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:23:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-zqFJMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-hqsdk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:23:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-MTnXPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:23:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-GHTFJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:23:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:23:52 INFO - Running setup.py install for manifestparser 23:23:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:23:52 INFO - Running setup.py install for mozcrash 23:23:52 INFO - Running setup.py install for mozdebug 23:23:52 INFO - Running setup.py install for mozdevice 23:23:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:23:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:23:52 INFO - Running setup.py install for mozfile 23:23:52 INFO - Running setup.py install for mozhttpd 23:23:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:23:53 INFO - Running setup.py install for mozinfo 23:23:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:23:53 INFO - Running setup.py install for mozInstall 23:23:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:23:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:23:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:23:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:23:53 INFO - Running setup.py install for mozleak 23:23:53 INFO - Running setup.py install for mozlog 23:23:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:23:53 INFO - Running setup.py install for moznetwork 23:23:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:23:53 INFO - Running setup.py install for mozprocess 23:23:53 INFO - Running setup.py install for mozprofile 23:23:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:23:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:23:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:23:54 INFO - Running setup.py install for mozrunner 23:23:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:23:54 INFO - Running setup.py install for mozscreenshot 23:23:54 INFO - Running setup.py install for moztest 23:23:54 INFO - Running setup.py install for mozversion 23:23:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:23:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:23:54 INFO - Cleaning up... 23:23:54 INFO - Return code: 0 23:23:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:54 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 0x10d9a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1c9d72be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d840e00>, '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 0x10d6a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d83bb20>, '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.fp6ou6qQxq/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.xI3CIXPRnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:23:54 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 23:23:54 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 23:23:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp6ou6qQxq/Render', 23:23:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:23:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:23:54 INFO - 'HOME': '/Users/cltbld', 23:23:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:23:54 INFO - 'LOGNAME': 'cltbld', 23:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:54 INFO - 'MOZ_NO_REMOTE': '1', 23:23:54 INFO - 'NO_EM_RESTART': '1', 23:23:54 INFO - 'PAGER': '/bin/cat', 23:23:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:54 INFO - 'PWD': '/builds/slave/test', 23:23:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:23:54 INFO - 'SHELL': '/bin/bash', 23:23:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xI3CIXPRnc/Listeners', 23:23:54 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:23:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:23:54 INFO - 'USER': 'cltbld', 23:23:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:23:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:54 INFO - 'XPC_FLAGS': '0x0', 23:23:54 INFO - 'XPC_SERVICE_NAME': '0', 23:23:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:23:54 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Sls95p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:23:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-MGws7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:23:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-bMvPvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:23:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Nhbkj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:23:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-vrTFjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:23:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-_CkTgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:23:55 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)) 23:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:23:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-KNwQzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:23:55 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)) 23:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:23:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-n1E7F6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:23:55 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)) 23:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:23:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-d8YHKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:23:55 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)) 23:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:23:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-gxE5XW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:23:56 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-O4aOMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:23:56 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-b8SyCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:23:56 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-oGQ6uI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:23:56 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-74GME1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:56 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-37q3al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:56 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)) 23:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:23:56 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-0Wv5ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:23:56 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)) 23:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:23:56 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-DttKYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:23:56 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)) 23:23:56 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)) 23:23:56 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)) 23:23:56 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)) 23:23:56 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)) 23:23:56 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)) 23:23:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:23:56 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 23:23:56 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 23:23:56 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 23:23:56 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 23:23:56 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 23:23:56 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 23:23:59 INFO - Downloading blessings-1.6.tar.gz 23:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:23:59 INFO - Installing collected packages: blessings 23:23:59 INFO - Running setup.py install for blessings 23:23:59 INFO - Successfully installed blessings 23:23:59 INFO - Cleaning up... 23:23:59 INFO - Return code: 0 23:23:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:23:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:23:59 INFO - Reading from file tmpfile_stdout 23:23:59 INFO - Current package versions: 23:23:59 INFO - blessings == 1.6 23:23:59 INFO - blobuploader == 1.2.4 23:23:59 INFO - docopt == 0.6.1 23:23:59 INFO - manifestparser == 1.1 23:23:59 INFO - mozInstall == 1.12 23:23:59 INFO - mozcrash == 0.17 23:23:59 INFO - mozdebug == 0.1 23:23:59 INFO - mozdevice == 0.48 23:23:59 INFO - mozfile == 1.2 23:23:59 INFO - mozhttpd == 0.7 23:23:59 INFO - mozinfo == 0.9 23:23:59 INFO - mozleak == 0.1 23:23:59 INFO - mozlog == 3.1 23:23:59 INFO - moznetwork == 0.27 23:23:59 INFO - mozprocess == 0.22 23:23:59 INFO - mozprofile == 0.28 23:23:59 INFO - mozrunner == 6.11 23:23:59 INFO - mozscreenshot == 0.1 23:23:59 INFO - mozsystemmonitor == 0.0 23:23:59 INFO - moztest == 0.7 23:23:59 INFO - mozversion == 1.4 23:23:59 INFO - psutil == 3.1.1 23:23:59 INFO - requests == 1.2.3 23:23:59 INFO - wsgiref == 0.1.2 23:23:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:59 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')]} 23:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:59 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')]} 23:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:59 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 0x10d9a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1c9d72be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d840e00>, '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 0x10d6a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d83bb20>, '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.fp6ou6qQxq/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.xI3CIXPRnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:23:59 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 23:23:59 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 23:23:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp6ou6qQxq/Render', 23:23:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:23:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:23:59 INFO - 'HOME': '/Users/cltbld', 23:23:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:23:59 INFO - 'LOGNAME': 'cltbld', 23:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:59 INFO - 'MOZ_NO_REMOTE': '1', 23:23:59 INFO - 'NO_EM_RESTART': '1', 23:23:59 INFO - 'PAGER': '/bin/cat', 23:23:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:59 INFO - 'PWD': '/builds/slave/test', 23:23:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:23:59 INFO - 'SHELL': '/bin/bash', 23:23:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xI3CIXPRnc/Listeners', 23:23:59 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:23:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:23:59 INFO - 'USER': 'cltbld', 23:23:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:23:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:59 INFO - 'XPC_FLAGS': '0x0', 23:23:59 INFO - 'XPC_SERVICE_NAME': '0', 23:23:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:24:00 INFO - Cleaning up... 23:24:00 INFO - Return code: 0 23:24:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1c9d72be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d840e00>, '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 0x10d6a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d83bb20>, '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.fp6ou6qQxq/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.xI3CIXPRnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp6ou6qQxq/Render', 23:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:00 INFO - 'HOME': '/Users/cltbld', 23:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:00 INFO - 'LOGNAME': 'cltbld', 23:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:00 INFO - 'MOZ_NO_REMOTE': '1', 23:24:00 INFO - 'NO_EM_RESTART': '1', 23:24:00 INFO - 'PAGER': '/bin/cat', 23:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:00 INFO - 'PWD': '/builds/slave/test', 23:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:00 INFO - 'SHELL': '/bin/bash', 23:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xI3CIXPRnc/Listeners', 23:24:00 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:00 INFO - 'USER': 'cltbld', 23:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:00 INFO - 'XPC_FLAGS': '0x0', 23:24:00 INFO - 'XPC_SERVICE_NAME': '0', 23:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:00 INFO - Downloading/unpacking jsonschema 23:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:24:02 INFO - Downloading/unpacking functools32 (from jsonschema) 23:24:02 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 23:24:02 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 23:24:02 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 23:24:02 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 23:24:02 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 23:24:02 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 23:24:03 INFO - Downloading functools32-3.2.3-2.tar.gz 23:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:24:03 INFO - warning: no files found matching '*.txt' 23:24:03 INFO - no previously-included directories found matching 'build' 23:24:03 INFO - no previously-included directories found matching 'dist' 23:24:03 INFO - no previously-included directories found matching '.git*' 23:24:03 INFO - Installing collected packages: jsonschema, functools32 23:24:03 INFO - Running setup.py install for functools32 23:24:03 INFO - warning: no files found matching '*.txt' 23:24:03 INFO - no previously-included directories found matching 'build' 23:24:03 INFO - no previously-included directories found matching 'dist' 23:24:03 INFO - no previously-included directories found matching '.git*' 23:24:03 INFO - Successfully installed jsonschema functools32 23:24:03 INFO - Cleaning up... 23:24:03 INFO - Return code: 0 23:24:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:24: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')]} 23:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24: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')]} 23:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1c9d72be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d840e00>, '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 0x10d6a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d83bb20>, '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.fp6ou6qQxq/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.xI3CIXPRnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:24:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:24:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp6ou6qQxq/Render', 23:24:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:03 INFO - 'HOME': '/Users/cltbld', 23:24:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:03 INFO - 'LOGNAME': 'cltbld', 23:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:03 INFO - 'MOZ_NO_REMOTE': '1', 23:24:03 INFO - 'NO_EM_RESTART': '1', 23:24:03 INFO - 'PAGER': '/bin/cat', 23:24:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:03 INFO - 'PWD': '/builds/slave/test', 23:24:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:03 INFO - 'SHELL': '/bin/bash', 23:24:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xI3CIXPRnc/Listeners', 23:24:03 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:24:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:03 INFO - 'USER': 'cltbld', 23:24:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:03 INFO - 'XPC_FLAGS': '0x0', 23:24:03 INFO - 'XPC_SERVICE_NAME': '0', 23:24:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:03 INFO - Downloading/unpacking flake8 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:24:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:24:06 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 23:24:06 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 23:24:06 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 23:24:06 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 23:24:06 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 23:24:06 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 23:24:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:24:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:24:06 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 23:24:06 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 23:24:06 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 23:24:06 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 23:24:06 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 23:24:06 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 23:24:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:24:06 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 23:24:06 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 23:24:06 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 23:24:06 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 23:24:06 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 23:24:06 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 23:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:24:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:24:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:24:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:24:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:24:07 INFO - no previously-included directories found matching 'docs/_build' 23:24:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:24:07 INFO - Running setup.py install for pep8 23:24:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:24:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:24:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:24:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:24:07 INFO - no previously-included directories found matching 'docs/_build' 23:24:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:24:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:24:07 INFO - Cleaning up... 23:24:07 INFO - Return code: 0 23:24:07 INFO - Running post-action listener: _resource_record_post_action 23:24:07 INFO - Running post-action listener: _start_resource_monitoring 23:24:07 INFO - Starting resource monitoring. 23:24:07 INFO - ##### 23:24:07 INFO - ##### Running install step. 23:24:07 INFO - ##### 23:24:07 INFO - Running pre-action listener: _resource_record_pre_action 23:24:07 INFO - Running main action method: install 23:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:24:08 INFO - Reading from file tmpfile_stdout 23:24:08 INFO - Detecting whether we're running mozinstall >=1.0... 23:24:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:24:08 INFO - Reading from file tmpfile_stdout 23:24:08 INFO - Output received: 23:24:08 INFO - Usage: mozinstall [options] installer 23:24:08 INFO - Options: 23:24:08 INFO - -h, --help show this help message and exit 23:24:08 INFO - -d DEST, --destination=DEST 23:24:08 INFO - Directory to install application into. [default: 23:24:08 INFO - "/builds/slave/test"] 23:24:08 INFO - --app=APP Application being installed. [default: firefox] 23:24:08 INFO - mkdir: /builds/slave/test/build/application 23:24:08 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'] 23:24:08 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 23:24:39 INFO - Reading from file tmpfile_stdout 23:24:39 INFO - Output received: 23:24:39 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 23:24:39 INFO - Running post-action listener: _resource_record_post_action 23:24:39 INFO - ##### 23:24:39 INFO - ##### Running run-tests step. 23:24:39 INFO - ##### 23:24:39 INFO - Running pre-action listener: _resource_record_pre_action 23:24:39 INFO - Running main action method: run_tests 23:24:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:24:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:24:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:24:39 INFO - 2016-05-11 23:24:39.610 screenresolution[1945:20147] starting screenresolution argv=screenresolution get 23:24:39 INFO - 2016-05-11 23:24:39.613 screenresolution[1945:20147] Display 0: 1600x1200x32@60 23:24:39 INFO - 2016-05-11 23:24:39.618 screenresolution[1946:20149] starting screenresolution argv=screenresolution list 23:24:39 INFO - Available Modes on Display 0 23:24:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:24:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:24:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:24:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:24:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:24:39 INFO - Intel Iris: 23:24:39 INFO - Chipset Model: Intel Iris 23:24:39 INFO - Type: GPU 23:24:39 INFO - Bus: Built-In 23:24:39 INFO - VRAM (Dynamic, Max): 1536 MB 23:24:39 INFO - Vendor: Intel (0x8086) 23:24:39 INFO - Device ID: 0x0a2e 23:24:39 INFO - Revision ID: 0x0009 23:24:39 INFO - Displays: 23:24:39 INFO - Display: 23:24:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:24:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:24:39 INFO - Display Serial Number: 1600x1200 60 23:24:39 INFO - Main Display: Yes 23:24:39 INFO - Mirror: Off 23:24:39 INFO - Online: Yes 23:24:39 INFO - Rotation: Supported 23:24:39 INFO - Return code: 0 23:24:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:24:39 INFO - Python 2.7.3 23:24:39 INFO - Return code: 0 23:24:39 INFO - grabbing minidump binary from tooltool 23:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:39 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 0x10d840e00>, '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 0x10d6a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d83bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:24:39 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 23:24:39 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 23:24:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:24:39 INFO - Return code: 0 23:24:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:24:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:24:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:24:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:24:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:24:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:24:41 INFO - Return code: 0 23:24:41 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/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--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 23:24:41 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/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0073 --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 23:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp6ou6qQxq/Render', 23:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:41 INFO - 'HOME': '/Users/cltbld', 23:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:41 INFO - 'LOGNAME': 'cltbld', 23:24:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:24:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:41 INFO - 'MOZ_NO_REMOTE': '1', 23:24:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:24:41 INFO - 'NO_EM_RESTART': '1', 23:24:41 INFO - 'PAGER': '/bin/cat', 23:24:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:41 INFO - 'PWD': '/builds/slave/test', 23:24:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:41 INFO - 'SHELL': '/bin/bash', 23:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xI3CIXPRnc/Listeners', 23:24:41 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:41 INFO - 'USER': 'cltbld', 23:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:41 INFO - 'XPC_FLAGS': '0x0', 23:24:41 INFO - 'XPC_SERVICE_NAME': '0', 23:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:41 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/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--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 23:24:41 INFO - mozversion application_buildid: 20160511211918 23:24:41 INFO - mozversion application_changeset: 2fb177e17d81e069a02797c6234e8ed085cbc55c 23:24:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:24:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:24:41 INFO - mozversion application_name: Firefox 23:24:41 INFO - mozversion application_remotingname: firefox-dev 23:24:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:24:41 INFO - mozversion application_vendor: Mozilla 23:24:41 INFO - mozversion application_version: 48.0a2 23:24:41 INFO - mozversion platform_buildid: 20160511211918 23:24:41 INFO - mozversion platform_changeset: 2fb177e17d81e069a02797c6234e8ed085cbc55c 23:24:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:24:41 INFO - mozversion platform_version: 48.0a2 23:24:41 INFO - using testdate: 1463034281 23:24:41 INFO - actual date: 1463034281 23:24:41 INFO - starting webserver on 'localhost:57215' 23:24:41 INFO - SUITE-START | Running 2 tests 23:24:41 INFO - TEST-START | dromaeo_css 23:24:41 INFO - operating with platform_type : mac_ 23:24:41 INFO - Initialising browser for dromaeo_css test... 23:24:41 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmp4hBm0f/profile http://localhost:57215/getInfo.html) 23:24:43 INFO - PROCESS | 1964 | __metrics Screen width/height:1600/1200 23:24:43 INFO - PROCESS | 1964 | colorDepth:24 23:24:43 INFO - PROCESS | 1964 | Browser inner width/height: 1024/689 23:24:43 INFO - PROCESS | 1964 | __metrics 23:24:43 ERROR - PROCESS | 1964 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:24:44 INFO - TEST-INFO | 1964: exit 0 23:24:44 INFO - Browser initialized. 23:24:44 INFO - Running cycle 1/1 for dromaeo_css test... 23:24:44 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmp4hBm0f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:24:56 INFO - PROCESS | 1967 | RSS: Main: 220839936 23:24:56 INFO - PROCESS | 1967 | 23:25:46 INFO - PROCESS | 1967 | 1463034346194 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] 23:27:57 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57215/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57215/tests/dromaeo/cssquery-ext.html) 23:27:59 INFO - PROCESS | 1967 | RSS: Main: 231084032 23:27:59 INFO - PROCESS | 1967 | 23:31:01 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57215/tests/dromaeo/cssquery-ext.html (next: http://localhost:57215/tests/dromaeo/cssquery-jquery.html) 23:31:01 INFO - PROCESS | 1967 | RSS: Main: 242774016 23:31:01 INFO - PROCESS | 1967 | 23:34:03 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57215/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57215/tests/dromaeo/cssquery-mootools.html) 23:34:04 INFO - PROCESS | 1967 | RSS: Main: 244838400 23:34:04 INFO - PROCESS | 1967 | 23:37:05 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57215/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57215/tests/dromaeo/cssquery-prototype.html) 23:37:06 INFO - PROCESS | 1967 | RSS: Main: 246800384 23:37:06 INFO - PROCESS | 1967 | 23:40:09 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57215/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57215/tests/dromaeo/cssquery-yui.html) 23:40:09 INFO - PROCESS | 1967 | RSS: Main: 250372096 23:40:09 INFO - PROCESS | 1967 | 23:43:12 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57215/tests/dromaeo/cssquery-yui.html (next: http://localhost:57215/tests/dromaeo/cssquery-dojo.html) 23:43:12 INFO - PROCESS | 1967 | RSS: Main: 250433536 23:43:12 INFO - PROCESS | 1967 | 23:43:12 INFO - PROCESS | 1967 | __start_tp_report 23:43:12 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 23:43:12 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 23:43:12 INFO - PROCESS | 1967 | |i|pagename|runs| 23:43:12 INFO - PROCESS | 1967 | |0;dojo.html;2922.4447355002553;3287.1124796304985;3476.2699833035067;3511.0520159556922;3534.982325088374;4770.475247722748;5760.164776107462;5770.538356931446;5791.623544469607;5793.507551858092;5736.254286942692;5743.885122297562;5770.480656740892;5809.157672137548;5813.505852002585;4352.194843953878;5031.924521132186;5258.6581872178285;5290.338707661543;5343.904499577578;5149.304843846089;5278.894422111555;5299.867503312409;5306.893862122755;5411.972940135293;4308.224519586473;5087.651772280348;5216.76524556394;5336.226247194155;5351.143816989283;4503.729776213421;5314.096603577401;5324.653897496651;5324.7071411072375;5330.706811125387;5217.16525355945;5243.318368612094;5250;5275.709835959021;5400;4120.896977575555;5605.859853503654;5647.943520564783;5657.886842263173;5667.773289068432;5479.931413374394;5797.362290148122;6195.256569211723;6266.686665666744;6321.936780632181;5630.733085055871;5857.912131318034;6146.985747351681;6157.168782214389;6263.6868156592445;5876.559258055663;5883.764649414018;5887.5584331174905;5900.793472228452;5903.409659034105;6348.523860710465;6375.2668443128705;6382.138411314413;6383.202099737533;6388.6166829989415;6058.212432383762;6133.4264757247465;6140.140380346755;6142.280161554771;6157.753689852445;6204.193454850931;6213.37866213375;6293.433590976834;6304.5271604628915;6324.936750632435;6139.4781443577795;6232.501399888089;6236.18929539166;6245.437910588069;6265.592736472206;6040.516758659297;6120.508083830883;6144.310314663414;6208.2239720034995;6227.501799856001;4956.504349565014;4971.1797553403285;4974.676646017997;4979.57673597741;4980.302757613937;3758.398656215047;4424.557544245549;4458.331250312479;4470.374147619336;4501.3022981437925;5725.169850371756;5823.505002074871;5865.794697185578;5879.882402351929;5939.792107276225;6203.379662033761;6227.595206311576;6230.937690623126;6255.6872156392;6262.46769024638;5678.943210567842;5833.329167145747;5842;5842.065269556935;5871;5442.265294185234;5500.724963751796;5501.14732216507;5528.170774383874;5552.139418390156;6473.28793832678;6502.707378167899;6503.382178693017;6506.056621789909;6541.182352205974;6116.396640261158;6200;6217.880781459381;6250.468710159687;6257.68711564429;6341.587796793194;6362.45919096882;6412.006139048455;6415.326390729093;6432.067350234283;6138.07928810682;6145.385461453819;6178.443940045418;6232.25212974446;6233.719482623203;6149.41580549847;6179.0422484514975;6183.319834818077;6254.124422580751;6307.842303942438;6051.402567140931;6211.068339749074;6212.471939884979;6215.968920155551;6269.811905642838;5217.321748172713;6147.139400484025;6189.876202476015;6194.5044396449075;6209;4661.883452913568;5132.947745712046;5864.296284445893;5965.940340596539;6002.249718785152;6118.663473509;6187.81436556886;6197.752089916353;6200.875982480416;6226.439620434183;6012.849678758066;6084.402349838071;6091.634501929899;6107.175531303217;6108.511319094373 23:43:12 INFO - PROCESS | 1967 | |1;ext.html;501.9874503137421;509.61269435229224;547.5728931433483;548.3721139295507;581.0267801432601;38834;40627.984300392505;40638;40678;40913.3862992055;41895.790521047355;42310.788446057726;42705;43099.78450107753;43260.783696081475;9512.857307140399;9662.758431039245;9694.66068687596;9772.706818795448;9818.361806482591;9605.135537801596;9702.320837541374;9709.223262139047;9716.805663886718;9719.805603887919;9598.088181622734;9605.903940960607;9652.131308182263;9724.270679699015;9742;9573.186279166279;9592.232621390272;9613.807723845484;9650.855237171449;9716.999999999965;9637.759056023586;9730.36752611078;9745.658901938468;9775.169110625606;9785.461799601018;39103.41344879829;39265.80367098146;39301;39330;39482;3178.55500229968;3267.950980735267;3337.0823023668445;3351.078453425303;3718.8140592970512;20847.5830483391;26935.461290774074;27465.31336716578;27534.173974780788;27881.58177627337;2613.46423983083;2651.4034342273026;2707.350235943379;2758.9586156207674;2865.126136528358;405850.9707451473;409299;409527;411297;411738;36707.63292367096;62211.37788622056;63218.36781632217;63495.6825215871;63504.68247658825;34237.82881085579;34804;35104.29791404158;35328.11679708028;35426.822865886024;15403.845961540464;15701.607459813367;15707.214639267992;15717.371305147666;15731;12977.416016279101;13039.152455090389;13241.404136813866;13257.403416846073;13263.336833158304;8079.798005049921;8098.554579498066;8285.917140828635;8287.544185069879;8433.241008309282;3468.2716629508086;3493.318802833423;3507.473878918183;3527.365074286653;3532.3288575170636;876.8465518534358;885.4465958775766;919.1773362840221;923.2613908873009;927.8979312275644;26107.216783496526;26200.475990480463;26547.070852520454;26554;26560.46879062408;958.434523631061;962.2150910061874;962.2879069488667;1061.87257529097;1080.287010573018;13576.456941722417;15779.368825246862;15867.761983570255;16094.597635058983;16478.2584783685;577484;608586;630201;632872.8356358189;632970;64867.35132648613;65197;65224.67387663031;65659.67170164119;66065.66967165134;1366.5353779714944;1526.6107142678768;1553.2777258574818;1570.0344288262636;1570.8350623184629;30449;31213.68786312108;31287.687123129388;31345;31646.841765791945;40377.1924561513;48465.03069938652;51173.720656983875;55086.173707395224;55331.17003245035;457241.7137914289;532953;536266;536604;539101;41574.792126039174;42562;43676.34485482784;44005.33991990187;44127.558724412345;46280.768596156806;46433;46526;48121.27818082801;48209.75895120502;31752.206194844388;38297.23405531929;38604.22791544097;38837.41743873787;39765.80117099396;35553.82223088868;35676.64323356837;35699.286014280086;35919.461208081375;36035.27929441449;32283.838580806947;35053.47419788654;36490.452643210905;38286.808565958105;38739.80630096832;31018.914337998965;32284.677153228167;33426.665733343325;33658.158546036546;34216.97349079532;25107.372315692253;25185.74814251834;25207.36981575402;25594.232173034838;25610.487790244464 23:43:12 INFO - PROCESS | 1967 | |2;jquery.html;398.9401589761537;401.0815233116165;403.1916008403151;410.39671682626545;412.1221797571174;14726.63183420415;19817;20281.290154844566;20545.589088218265;20558.0748866301;20059.799402005974;20915.267965621206;20948.895255523737;21416.25043123491;21752.347429577138;5713.971430142843;5740.138979153139;5989.131575921489;6036.637801731888;6041.667708276043;5006.649534532584;5870.559708021894;5947.464728174464;5980.312264089642;5990.580659353847;5635.126555383901;5892;5926.229590153274;5926.97036514819;5968.582199246054;5716.399778023331;5753.856153596173;5822.214001109838;5846.736896839652;5883.794067207627;4791.448983366888;5885.8822823543715;5935.732892019826;5937.109433584954;5953.7320820562745;13490.662733431645;13609.387577559033;14401.567952961428;24915;25040;2076.007202677563;2093.4661661276277;2193.824494040473;2272.659101134843;2746.5880117982265;9742.9512852436;9759.756006099904;9821.508924553744;10147.441890696009;10585.894141058568;1755.8244175582468;1851.7129844873932;1852.6572584071855;1853.4532312967706;1873.3911478769319;113988;114327;117504;119892;121834.99999999911;11884.643460696192;12005;12073.215241009306;12089.637310880687;12218.327991960528;15472.922635386976;15499.922500387425;15550.533483995498;15556.22218889051;15586;9112.726618201465;9142.314326425545;9151.496667683208;9153.67962121336;9250.583723732449;7868.859015442728;9131.315151363675;9157.946836113932;9186.173244407903;9261;3985.7608543487486;4431.1137772445;4856.611471082305;4863.319135321058;4865.416150062015;1701.4045084220672;1731.3940120957816;2012.7219215798073;2050.9642630471517;2093.6126816538685;586.3960121075299;760.634895250283;761.4061032394741;779.4738551477843;834.2575108153748;14602.707945841024;17906.839651849867;18064;18091.638167236844;18986.335478258196;676.8307923019245;841.2891107014563;853.0829358439578;868.3574155125289;880.7709995401242;9719.416834989923;9748.366356186825;9911.355761875455;9918.40489570628;9986.20110391167;607452;614484;617089;617259;627341;69412;71466.285337147;98200;106508;114080.85919140869;926.1433174313732;936.5317341329335;949.4872768704822;950.6292545907102;1004.8995100490039;17598.91200543989;17806.37677681275;17967.82032179714;18211.089445527934;18498.537536561693;47718.284225735944;47961.5203847957;48033.519664804306;48820.75589622029;49927;56453.30640080804;69081.96377054248;74684.62657686677;76217.61891190508;76511.23488765041;7939.801504962422;8263.586820658822;8269.421140520106;8408.411411201158;8445.831083378422;12082.51669933228;12212.694682633006;12573.811392829299;12739.426725797546;12973.221606703628;8555.443896146731;10162.695119146438;10234.948825255826;10277.794444110927;10292.022257885488;9397.248220142235;9491.71524854228;10140.898591013995;10169.745756356151;10303.175745940156;9681.467519286507;9997.550110245202;10037.247206459399;10106.494675266355;10622.25644204929;6807.625580593115;7327.560346379234;8504.107068757692;8524.147585241675;8812.250958668585;8055;9889.258305626963;10523.263371564224;10536.157107431234;10575.682729518127 23:43:12 INFO - PROCESS | 1967 | |3;mootools.html;1534.3479021415899;1605.6226786705122;1831.3956394389845;1902.5624106455514;1991.4722598511405;7980;8572.699955501559;8654.87017694735;8767.561621918903;8792.472451652906;8696.652133914651;8765.298776097912;8822.117788221174;8843.955780221106;8879.156480134394;2410.7468715784853;2432.5621388150125;2433.6227884677814;2439.4633180700307;2443.181534186041;2010.7486564179478;2268;2401.735809061002;2432.0150339112597;2449.632555116729;2335.1243283768586;2351.2828587280874;2368.431576421655;2379.143508337006;2382.642603609464;2420.0440825873857;2445.596476581362;2445.9755402446017;2450.252672934754;2470.7899828514596;2430.4409985703387;2453.129139155592;2456.0175929628112;2457.9877100614563;2466.8273220874544;9036.322275829274;9048.457092574467;9060.864087038633;9064.184223419858;9109.772255693595;5418.566514678816;5552.639078459887;5554.9722251388885;5572.219889215513;5580.944190558123;3542.291541691646;3632.872849450283;3632.963670363289;3637.563492380905;3694.2057457646465;1056.3503445381111;1078.56857257097;1078.811208038598;1082.4587706146926;1083.7940791249637;9792.629031935534;11871.940640296743;12266.202696824677;12296.754064918652;12324.75350492994;4743.762811859393;4783.215675402702;4857.757112144379;4881.438634557;4894.828680996148;10278.691639250685;10344.844827327595;10359.533820978075;10363.896361036444;10391.220658450646;5409.945900541023;5458.099413596712;5507.173923911445;5521.950829342492;5522.861928451821;4447.533009034069;4813.470518242991;4878.121938051185;4892.217245240816;4916.139675556763;3709.8330575124182;4063.837446502166;4124.05146816234;4182.226288136704;4211.873643790691;1334.759743246225;1354.5733094075335;1359.5989183190982;1365.1058556645414;1369.349558959506;853.2022558907441;872.6204101215991;892.2214421923151;899.3479727197729;913.8583519554479;5432.837014889559;5623.044082505902;5664.54683625309;5711.314642242957;5876.059830427112;911.7128104647015;914.3782228084966;948.3598570964709;949.7435692363023;959.8704174936433;3580.856765729394;3592.4611308303965;3652.726045546595;3678.2275722098657;3682.4844521766972;10419.905909879353;10673.83989240162;10870.836937445945;10992.560297588007;11065.170112241614;10601;10730.19523535738;10766.354018758899;10893.83659245112;10895.673129806119;8374.581270936429;8477.364197685198;8482.448640838325;8540.53027083504;8551.315894728406;5249.895002100013;5390.245365648891;5447.319085114361;5476.972615136899;5492;9350.485723285285;9534.904650953402;9706.126448619658;9720.027997200223;9723.270754693285;9752.171065459515;10040.347377420445;10042;10184.898151018395;10186.981301869753;6887.139107611549;7193;7351.117865856131;7470.514416562906;7545.50954187976;8386.958065209636;8392;8438.789030274293;8454.239118479367;8458.830823383621;7296.343329100407;7305.452091093083;7449.106107267163;7532.13380461232;7578.242175782378;7228.20489746117;7305.2329505403295;7335.926640733524;7406.481546291708;7408.111026676834;6806.387425131762;6845.110135682329;6867.244603093755;6874.106366172366;6885.1049363582415;4620.3993480847275;4633.559811817872;4659.836905708419;4751;4756.025014871874;4661.324108004253;4676.929846052244;4702.882427939329;4707.599854012447;4721.362616046789 23:43:12 INFO - PROCESS | 1967 | |4;prototype.html;257.74734788925815;272.9194887508184;308.51255017073044;321.6976042520031;322.0708256679479;6168.660723660197;6675.66621668917;6724.630145342005;6744.325567443259;6765.391114799667;5392.541633961118;6646.136002319704;6657.467402607792;6745.325467453252;6777.695003724832;4936.531029552187;4969.981153863449;4983.152864013126;4990.05189014088;4995.650304478688;4973.776180071905;4997.075541024904;4998;5004.224345226477;5018.974905125469;4014.1770936958;4533.7053091549105;4692.741899195543;4943.233798761198;4959.280904268879;4775.259834725588;4929.309896614477;4947.307376967227;4963;4966.15575352191;4198.958010419918;4227.365895115727;4233.491980962273;4249.893752656209;4257.212415703074;5141.640085194038;6482.805515834532;6494.058361537551;6496.382843629847;6509.251436084864;5830.358660547379;5883.029300165467;5887.264091988502;5900.704964751745;5901.114832775118;7217.350438460511;7222.09723784527;7252.274772522758;7258.693435181665;7266.237045110241;4606.838760643395;4664.626829853603;4747.881302967419;4758.238681810928;4761.6190704743885;7617.542947423117;7679;7706.306432421053;7714.421418393643;7727.38180945523;4812.590929771009;4827.662063655511;4827.951720482821;4829.396325459317;4838.225883858636;4905.117078925828;4914.0908931847725;4929.334539837076;4934.358533390637;4944.307796908436;5858.619189752652;5862.3585396089165;5869.119632055226;5875.383084776123;5876.529877609781;5795.9420405796245;5811.854703632443;6957.130358705162;7245.746398876014;7353.742619008309;1644.9506514804575;1654.139847279432;1670.941517046922;1673.548142001677;1675.631361100556;1040.386172158415;1040.9167266618651;1062.7290041039485;1064.1965316186383;1066.9466526673634;6509;6583.44040756541;6784.966075169691;6785.287544807823;6814.046033555306;6895.275996020446;7596.886046709304;7624.2464233226665;7644.694212231449;7654.540727556365;6751.493637977172;6755.527113102035;6777.762778302736;6781.796546103625;6813.420859226922;4005.178938317638;4021.4571032910185;4028.113814960704;4038.2529232092156;4044.4742183515955;7640.312371886557;7922.445428819928;7927.4054445915635;8001.279884810395;8013.759587212393;7829;7894.447388682852;7907.367410607138;7915.366770658334;7958.3235424989525;6521.8695626088165;7425.848993406031;7986.680532778624;8012.599370031475;8019.997500312461;6448.548601597843;7302.3792977597495;7616.619169041636;7622.123455802654;7624.313811756969;7515.2109028553405;7520.00719809262;7521;7549.433792465477;7555.6977720890545;7979.045133941989;8014.919850801417;8026.558539280162;8055.395845311742;8102.7569172924905;3924.862629807943;4639.257718764981;4710.764461776829;4722.976385118052;4739.644526660445;6152.876942461036;7231.674574644258;7524.984127142766;7576.24237576238;7702.653380597774;7251;7305;7306.41548676094;7349.375303099083;7377.741779037708;5938.851528711644;7307.378872795872;7308.780736577911;7327.487075904635;7352.375048120755;5771.336296325976;7125.966734823525;7157.85684286301;7178.497505174588;7202.551132614936;5823.563232757645;7187.993680884785;7270.636468176675;7321.963390183015;7323.523970942085;6833.453323734188;7022.367986881205;7088.681009354695;7090.929090709027;7141.678624462015 23:43:12 INFO - PROCESS | 1967 | |5;yui.html;614.747953339131;682.2699711308901;740.8296091898864;750.3359526818764;754.4304050441915;14562.563123106298;14590.854091459083;14695.265236738174;14703.926480367596;14828.6292842679;13611.863881361209;13622.659433514167;13636.113652612574;13637.659058523517;13649.839763620104;722.9313215244543;887.6183241206279;901.2519608724742;918.4305730447098;920.3051695969534;905.1446383167909;915.8626206069109;918.4030380252856;918.9586468608928;922.4280945813605;960.8558716192592;964.3490643815431;964.5273815830228;965.9758506037335;967.7145242153547;918.8575770755577;919.3426699909596;920.3741455810047;935.7707361696359;957.7366224288342;700.3696672994295;707.85135121624;708.6633848921772;711.2602892991283;714.0003994407818;12143.757124857542;14619.561413157622;14622.049566778125;14642.487512937103;14676.779848302178;12499.56251531192;12539.874601254052;12593.37033148339;12647.17793343439;12796.232226066373;9938.062077894814;9952.253580981383;10224.437655928921;10284.43435611041;10312.793744125076;3480.796209666539;3487.424574945131;3510.4909788080586;3561.71506279497;3743.9812800936093;74219;74565.25434745637;74567;74629.62685186593;75753.62123189404;8740.169683880022;8796.34027447944;9663.13031827139;9684.273679474067;9773.31586788918;21515.462113447287;21592.784072159393;21601;21601.351959441243;21624.675629865564;7509.324160825552;7538.020057392504;7580.583067931207;7607.125180604191;7839.216078392229;4129.009037830899;4191.7694526801315;4192.203481338536;4197.538270790211;4202.2646036943415;3579.6599323064265;3638.799866007342;3654.086478380405;3659.451082337617;3664.4686520454384;647.3591144766741;656.2485953583121;669.4142625202948;675.2336098528206;675.6419097878132;533.168257518265;566.9461401166883;571.0178492992047;581.8894410062074;625.6246252248615;7350.4119670426235;7688.730894418669;7708.768736937901;7714.614269286513;7727.459077864608;520.0119772432408;526.7971830845153;554.938956714761;573.3206150711337;598.3328588623654;3473.7221022318154;3607.6572725591027;3657.122290650278;3702.4631428443263;3902.707296952683;83873.58063209767;89725.55137224273;89840.5507972469;90592.54703726571;91336.543317283;73904.63047684835;74414.62792686002;74997;75030.12424689427;75663;68254;69540.30459695339;70326.9450958236;70952.64523677349;71108.86673399806;8177.632006559838;8200.917990820015;8273.586320684062;8450.873236901329;8543.0572682385;46400.8399790008;46773.53226467828;46788.59634210979;47664.52335476739;47908.5209147904;58108.41891581199;58810.11784823317;60588.39411606004;60740;61808;8654.394192406471;10630.73423164427;10779.13766898662;10995.835062473909;11371;9229.584668690059;11443.485043173243;11882.227655202385;11887.395141950268;12105.334206618369;11178.217524773188;11309.390254239257;11408.315501069963;11669.76660466803;11698.4735686896;11412.201145919706;11494.885051149382;11508.13688973347;11615.303081815118;11664.558033890902;11055.889441105486;11060.557577697124;11136.888631113585;11536.94231528837;11656.368108464652;9522.571484283362;9724.70825875225;9735.707928761865;9805.28199419973;9956.850647240442;9591.616335346507;9653.951730241304;9708.902910971083;9796.314258001872;9816 23:43:12 INFO - PROCESS | 1967 | __end_tp_report 23:43:12 INFO - PROCESS | 1967 | __start_cc_report 23:43:12 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,421 23:43:12 INFO - PROCESS | 1967 | __end_cc_report 23:43:12 INFO - PROCESS | 1967 | __startTimestamp1463035392281__endTimestamp 23:43:12 INFO - PROCESS | 1967 | 23:43:12 INFO - PROCESS | 1967 | ------- Summary: start ------- 23:43:12 INFO - PROCESS | 1967 | Number of tests: 6 23:43:12 INFO - PROCESS | 1967 | 23:43:12 INFO - PROCESS | 1967 | [#0] dojo.html Cycles:165 Average:5730.77 Median:5939.79 stddev:696.50 (11.7%) stddev-sans-first:662.88 23:43:12 INFO - PROCESS | 1967 | Values: 2922.4 3287.1 3476.3 3511.1 3535.0 4770.5 5760.2 5770.5 5791.6 5793.5 5736.3 5743.9 5770.5 5809.2 5813.5 4352.2 5031.9 5258.7 5290.3 5343.9 5149.3 5278.9 5299.9 5306.9 5412.0 4308.2 5087.7 5216.8 5336.2 5351.1 4503.7 5314.1 5324.7 5324.7 5330.7 5217.2 5243.3 5250.0 5275.7 5400.0 4120.9 5605.9 5647.9 5657.9 5667.8 5479.9 5797.4 6195.3 6266.7 6321.9 5630.7 5857.9 6147.0 6157.2 6263.7 5876.6 5883.8 5887.6 5900.8 5903.4 6348.5 6375.3 6382.1 6383.2 6388.6 6058.2 6133.4 6140.1 6142.3 6157.8 6204.2 6213.4 6293.4 6304.5 6324.9 6139.5 6232.5 6236.2 6245.4 6265.6 6040.5 6120.5 6144.3 6208.2 6227.5 4956.5 4971.2 4974.7 4979.6 4980.3 3758.4 4424.6 4458.3 4470.4 4501.3 5725.2 5823.5 5865.8 5879.9 5939.8 6203.4 6227.6 6230.9 6255.7 6262.5 5678.9 5833.3 5842.0 5842.1 5871.0 5442.3 5500.7 5501.1 5528.2 5552.1 6473.3 6502.7 6503.4 6506.1 6541.2 6116.4 6200.0 6217.9 6250.5 6257.7 6341.6 6362.5 6412.0 6415.3 6432.1 6138.1 6145.4 6178.4 6232.3 6233.7 6149.4 6179.0 6183.3 6254.1 6307.8 6051.4 6211.1 6212.5 6216.0 6269.8 5217.3 6147.1 6189.9 6194.5 6209.0 4661.9 5132.9 5864.3 5965.9 6002.2 6118.7 6187.8 6197.8 6200.9 6226.4 6012.8 6084.4 6091.6 6107.2 6108.5 23:43:12 INFO - PROCESS | 1967 | 23:43:12 INFO - PROCESS | 1967 | [#1] ext.html Cycles:180 Average:64812.30 Median:223239.48 stddev:139702.21 (62.6%) stddev-sans-first:140010.67 23:43:12 INFO - PROCESS | 1967 | Values: 502.0 509.6 547.6 548.4 581.0 38834.0 40628.0 40638.0 40678.0 40913.4 41895.8 42310.8 42705.0 43099.8 43260.8 9512.9 9662.8 9694.7 9772.7 9818.4 9605.1 9702.3 9709.2 9716.8 9719.8 9598.1 9605.9 9652.1 9724.3 9742.0 9573.2 9592.2 9613.8 9650.9 9717.0 9637.8 9730.4 9745.7 9775.2 9785.5 39103.4 39265.8 39301.0 39330.0 39482.0 3178.6 3268.0 3337.1 3351.1 3718.8 20847.6 26935.5 27465.3 27534.2 27881.6 2613.5 2651.4 2707.4 2759.0 2865.1 405851.0 409299.0 409527.0 411297.0 411738.0 36707.6 62211.4 63218.4 63495.7 63504.7 34237.8 34804.0 35104.3 35328.1 35426.8 15403.8 15701.6 15707.2 15717.4 15731.0 12977.4 13039.2 13241.4 13257.4 13263.3 8079.8 8098.6 8285.9 8287.5 8433.2 3468.3 3493.3 3507.5 3527.4 3532.3 876.8 885.4 919.2 923.3 927.9 26107.2 26200.5 26547.1 26554.0 26560.5 958.4 962.2 962.3 1061.9 1080.3 13576.5 15779.4 15867.8 16094.6 16478.3 577484.0 608586.0 630201.0 632872.8 632970.0 64867.4 65197.0 65224.7 65659.7 66065.7 1366.5 1526.6 1553.3 1570.0 1570.8 30449.0 31213.7 31287.7 31345.0 31646.8 40377.2 48465.0 51173.7 55086.2 55331.2 457241.7 532953.0 536266.0 536604.0 539101.0 41574.8 42562.0 43676.3 44005.3 44127.6 46280.8 46433.0 46526.0 48121.3 48209.8 31752.2 38297.2 38604.2 38837.4 39765.8 35553.8 35676.6 35699.3 35919.5 36035.3 32283.8 35053.5 36490.5 38286.8 38739.8 31018.9 32284.7 33426.7 33658.2 34217.0 25107.4 25185.7 25207.4 25594.2 25610.5 23:43:12 INFO - PROCESS | 1967 | 23:43:12 INFO - PROCESS | 1967 | [#2] jquery.html Cycles:180 Average:33778.22 Median:4864.37 stddev:102041.39 (2097.7%) stddev-sans-first:102296.86 23:43:12 INFO - PROCESS | 1967 | Values: 398.9 401.1 403.2 410.4 412.1 14726.6 19817.0 20281.3 20545.6 20558.1 20059.8 20915.3 20948.9 21416.3 21752.3 5714.0 5740.1 5989.1 6036.6 6041.7 5006.6 5870.6 5947.5 5980.3 5990.6 5635.1 5892.0 5926.2 5927.0 5968.6 5716.4 5753.9 5822.2 5846.7 5883.8 4791.4 5885.9 5935.7 5937.1 5953.7 13490.7 13609.4 14401.6 24915.0 25040.0 2076.0 2093.5 2193.8 2272.7 2746.6 9743.0 9759.8 9821.5 10147.4 10585.9 1755.8 1851.7 1852.7 1853.5 1873.4 113988.0 114327.0 117504.0 119892.0 121835.0 11884.6 12005.0 12073.2 12089.6 12218.3 15472.9 15499.9 15550.5 15556.2 15586.0 9112.7 9142.3 9151.5 9153.7 9250.6 7868.9 9131.3 9157.9 9186.2 9261.0 3985.8 4431.1 4856.6 4863.3 4865.4 1701.4 1731.4 2012.7 2051.0 2093.6 586.4 760.6 761.4 779.5 834.3 14602.7 17906.8 18064.0 18091.6 18986.3 676.8 841.3 853.1 868.4 880.8 9719.4 9748.4 9911.4 9918.4 9986.2 607452.0 614484.0 617089.0 617259.0 627341.0 69412.0 71466.3 98200.0 106508.0 114080.9 926.1 936.5 949.5 950.6 1004.9 17598.9 17806.4 17967.8 18211.1 18498.5 47718.3 47961.5 48033.5 48820.8 49927.0 56453.3 69082.0 74684.6 76217.6 76511.2 7939.8 8263.6 8269.4 8408.4 8445.8 12082.5 12212.7 12573.8 12739.4 12973.2 8555.4 10162.7 10234.9 10277.8 10292.0 9397.2 9491.7 10140.9 10169.7 10303.2 9681.5 9997.6 10037.2 10106.5 10622.3 6807.6 7327.6 8504.1 8524.1 8812.3 8055.0 9889.3 10523.3 10536.2 10575.7 23:43:12 INFO - PROCESS | 1967 | 23:43:12 INFO - PROCESS | 1967 | [#3] mootools.html Cycles:180 Average:5721.80 Median:4798.34 stddev:3214.13 (67.0%) stddev-sans-first:3207.74 23:43:12 INFO - PROCESS | 1967 | Values: 1534.3 1605.6 1831.4 1902.6 1991.5 7980.0 8572.7 8654.9 8767.6 8792.5 8696.7 8765.3 8822.1 8844.0 8879.2 2410.7 2432.6 2433.6 2439.5 2443.2 2010.7 2268.0 2401.7 2432.0 2449.6 2335.1 2351.3 2368.4 2379.1 2382.6 2420.0 2445.6 2446.0 2450.3 2470.8 2430.4 2453.1 2456.0 2458.0 2466.8 9036.3 9048.5 9060.9 9064.2 9109.8 5418.6 5552.6 5555.0 5572.2 5580.9 3542.3 3632.9 3633.0 3637.6 3694.2 1056.4 1078.6 1078.8 1082.5 1083.8 9792.6 11871.9 12266.2 12296.8 12324.8 4743.8 4783.2 4857.8 4881.4 4894.8 10278.7 10344.8 10359.5 10363.9 10391.2 5409.9 5458.1 5507.2 5522.0 5522.9 4447.5 4813.5 4878.1 4892.2 4916.1 3709.8 4063.8 4124.1 4182.2 4211.9 1334.8 1354.6 1359.6 1365.1 1369.3 853.2 872.6 892.2 899.3 913.9 5432.8 5623.0 5664.5 5711.3 5876.1 911.7 914.4 948.4 949.7 959.9 3580.9 3592.5 3652.7 3678.2 3682.5 10419.9 10673.8 10870.8 10992.6 11065.2 10601.0 10730.2 10766.4 10893.8 10895.7 8374.6 8477.4 8482.4 8540.5 8551.3 5249.9 5390.2 5447.3 5477.0 5492.0 9350.5 9534.9 9706.1 9720.0 9723.3 9752.2 10040.3 10042.0 10184.9 10187.0 6887.1 7193.0 7351.1 7470.5 7545.5 8387.0 8392.0 8438.8 8454.2 8458.8 7296.3 7305.5 7449.1 7532.1 7578.2 7228.2 7305.2 7335.9 7406.5 7408.1 6806.4 6845.1 6867.2 6874.1 6885.1 4620.4 4633.6 4659.8 4751.0 4756.0 4661.3 4676.9 4702.9 4707.6 4721.4 23:43:12 INFO - PROCESS | 1967 | 23:43:12 INFO - PROCESS | 1967 | [#4] prototype.html Cycles:180 Average:5893.12 Median:6552.65 stddev:1913.19 (29.2%) stddev-sans-first:1871.22 23:43:12 INFO - PROCESS | 1967 | Values: 257.7 272.9 308.5 321.7 322.1 6168.7 6675.7 6724.6 6744.3 6765.4 5392.5 6646.1 6657.5 6745.3 6777.7 4936.5 4970.0 4983.2 4990.1 4995.7 4973.8 4997.1 4998.0 5004.2 5019.0 4014.2 4533.7 4692.7 4943.2 4959.3 4775.3 4929.3 4947.3 4963.0 4966.2 4199.0 4227.4 4233.5 4249.9 4257.2 5141.6 6482.8 6494.1 6496.4 6509.3 5830.4 5883.0 5887.3 5900.7 5901.1 7217.4 7222.1 7252.3 7258.7 7266.2 4606.8 4664.6 4747.9 4758.2 4761.6 7617.5 7679.0 7706.3 7714.4 7727.4 4812.6 4827.7 4828.0 4829.4 4838.2 4905.1 4914.1 4929.3 4934.4 4944.3 5858.6 5862.4 5869.1 5875.4 5876.5 5795.9 5811.9 6957.1 7245.7 7353.7 1645.0 1654.1 1670.9 1673.5 1675.6 1040.4 1040.9 1062.7 1064.2 1066.9 6509.0 6583.4 6785.0 6785.3 6814.0 6895.3 7596.9 7624.2 7644.7 7654.5 6751.5 6755.5 6777.8 6781.8 6813.4 4005.2 4021.5 4028.1 4038.3 4044.5 7640.3 7922.4 7927.4 8001.3 8013.8 7829.0 7894.4 7907.4 7915.4 7958.3 6521.9 7425.8 7986.7 8012.6 8020.0 6448.5 7302.4 7616.6 7622.1 7624.3 7515.2 7520.0 7521.0 7549.4 7555.7 7979.0 8014.9 8026.6 8055.4 8102.8 3924.9 4639.3 4710.8 4723.0 4739.6 6152.9 7231.7 7525.0 7576.2 7702.7 7251.0 7305.0 7306.4 7349.4 7377.7 5938.9 7307.4 7308.8 7327.5 7352.4 5771.3 7126.0 7157.9 7178.5 7202.6 5823.6 7188.0 7270.6 7322.0 7323.5 6833.5 7022.4 7088.7 7090.9 7141.7 23:43:12 INFO - PROCESS | 1967 | 23:43:12 INFO - PROCESS | 1967 | [#5] yui.html Cycles:180 Average:17582.35 Median:31216.81 stddev:24340.99 (78.0%) stddev-sans-first:24375.92 23:43:12 INFO - PROCESS | 1967 | Values: 614.7 682.3 740.8 750.3 754.4 14562.6 14590.9 14695.3 14703.9 14828.6 13611.9 13622.7 13636.1 13637.7 13649.8 722.9 887.6 901.3 918.4 920.3 905.1 915.9 918.4 919.0 922.4 960.9 964.3 964.5 966.0 967.7 918.9 919.3 920.4 935.8 957.7 700.4 707.9 708.7 711.3 714.0 12143.8 14619.6 14622.0 14642.5 14676.8 12499.6 12539.9 12593.4 12647.2 12796.2 9938.1 9952.3 10224.4 10284.4 10312.8 3480.8 3487.4 3510.5 3561.7 3744.0 74219.0 74565.3 74567.0 74629.6 75753.6 8740.2 8796.3 9663.1 9684.3 9773.3 21515.5 21592.8 21601.0 21601.4 21624.7 7509.3 7538.0 7580.6 7607.1 7839.2 4129.0 4191.8 4192.2 4197.5 4202.3 3579.7 3638.8 3654.1 3659.5 3664.5 647.4 656.2 669.4 675.2 675.6 533.2 566.9 571.0 581.9 625.6 7350.4 7688.7 7708.8 7714.6 7727.5 520.0 526.8 554.9 573.3 598.3 3473.7 3607.7 3657.1 3702.5 3902.7 83873.6 89725.6 89840.6 90592.5 91336.5 73904.6 74414.6 74997.0 75030.1 75663.0 68254.0 69540.3 70326.9 70952.6 71108.9 8177.6 8200.9 8273.6 8450.9 8543.1 46400.8 46773.5 46788.6 47664.5 47908.5 58108.4 58810.1 60588.4 60740.0 61808.0 8654.4 10630.7 10779.1 10995.8 11371.0 9229.6 11443.5 11882.2 11887.4 12105.3 11178.2 11309.4 11408.3 11669.8 11698.5 11412.2 11494.9 11508.1 11615.3 11664.6 11055.9 11060.6 11136.9 11536.9 11656.4 9522.6 9724.7 9735.7 9805.3 9956.9 9591.6 9654.0 9708.9 9796.3 9816.0 23:43:12 INFO - PROCESS | 1967 | -------- Summary: end -------- 23:43:12 INFO - PROCESS | 1967 | 23:43:12 INFO - TEST-INFO | 1967: exit 0 23:43:12 INFO - TEST-OK | dromaeo_css | took 1111575ms 23:43:12 INFO - TEST-START | kraken 23:43:12 INFO - operating with platform_type : mac_ 23:43:12 INFO - Initialising browser for kraken test... 23:43:12 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpFYUZ0Z/profile http://localhost:57215/getInfo.html) 23:43:15 INFO - PROCESS | 1973 | __metrics Screen width/height:1600/1200 23:43:15 INFO - PROCESS | 1973 | colorDepth:24 23:43:15 INFO - PROCESS | 1973 | Browser inner width/height: 1024/689 23:43:15 INFO - PROCESS | 1973 | __metrics 23:43:15 ERROR - PROCESS | 1973 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:43:16 INFO - TEST-INFO | 1973: exit 0 23:43:16 INFO - Browser initialized. 23:43:16 INFO - Running cycle 1/1 for kraken test... 23:43:16 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpFYUZ0Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:43:28 INFO - PROCESS | 1976 | RSS: Main: 220880896 23:43:28 INFO - PROCESS | 1976 | 23:43:31 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57215/tests/kraken/driver.html?testName=audio-beat-detection) 23:43:32 INFO - PROCESS | 1976 | RSS: Main: 232898560 23:43:32 INFO - PROCESS | 1976 | 23:43:34 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57215/tests/kraken/driver.html?testName=audio-dft) 23:43:35 INFO - PROCESS | 1976 | RSS: Main: 241852416 23:43:35 INFO - PROCESS | 1976 | 23:43:38 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57215/tests/kraken/driver.html?testName=audio-fft) 23:43:39 INFO - PROCESS | 1976 | RSS: Main: 245354496 23:43:39 INFO - PROCESS | 1976 | 23:43:41 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57215/tests/kraken/driver.html?testName=audio-oscillator) 23:43:41 INFO - PROCESS | 1976 | RSS: Main: 247468032 23:43:41 INFO - PROCESS | 1976 | 23:43:43 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57215/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:43:44 INFO - PROCESS | 1976 | RSS: Main: 247660544 23:43:44 INFO - PROCESS | 1976 | 23:43:47 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57215/tests/kraken/driver.html?testName=imaging-darkroom) 23:43:48 INFO - PROCESS | 1976 | RSS: Main: 247828480 23:43:48 INFO - PROCESS | 1976 | 23:43:51 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57215/tests/kraken/driver.html?testName=imaging-desaturate) 23:43:51 INFO - PROCESS | 1976 | RSS: Main: 247959552 23:43:51 INFO - PROCESS | 1976 | 23:43:54 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57215/tests/kraken/driver.html?testName=json-parse-financial) 23:43:55 INFO - PROCESS | 1976 | RSS: Main: 248074240 23:43:55 INFO - PROCESS | 1976 | 23:43:56 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57215/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:43:57 INFO - PROCESS | 1976 | RSS: Main: 247443456 23:43:57 INFO - PROCESS | 1976 | 23:43:59 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:44:00 INFO - PROCESS | 1976 | RSS: Main: 247599104 23:44:00 INFO - PROCESS | 1976 | 23:44:02 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:44:02 INFO - PROCESS | 1976 | RSS: Main: 247603200 23:44:02 INFO - PROCESS | 1976 | 23:44:05 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:44:06 INFO - PROCESS | 1976 | RSS: Main: 247595008 23:44:06 INFO - PROCESS | 1976 | 23:44:09 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:44:09 INFO - PROCESS | 1976 | RSS: Main: 247693312 23:44:09 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57215/tests/kraken/driver.html?testName=ai-astar) 23:44:11 INFO - PROCESS | 1976 | RSS: Main: 249516032 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | __start_tp_report 23:44:11 INFO - PROCESS | 1976 | _x_x_mozilla_page_load 23:44:11 INFO - PROCESS | 1976 | _x_x_mozilla_page_load_details 23:44:11 INFO - PROCESS | 1976 | |i|pagename|runs| 23:44:11 INFO - PROCESS | 1976 | |0;ai-astar;114;118;121;169;164;137;96;158;96;147 23:44:11 INFO - PROCESS | 1976 | |1;audio-beat-detection;149;122;155;155;120;133;129;149;159;123 23:44:11 INFO - PROCESS | 1976 | |2;audio-dft;195;196;200;195;196;222;275;206;197;200 23:44:11 INFO - PROCESS | 1976 | |3;audio-fft;63;71;81;143;56;58;69;72;110;59 23:44:11 INFO - PROCESS | 1976 | |4;audio-oscillator;80;84;127;75;78;92;124;81;79;126 23:44:11 INFO - PROCESS | 1976 | |5;imaging-gaussian-blur;88;87;88;85;88;77;134;128;88;85 23:44:11 INFO - PROCESS | 1976 | |6;imaging-darkroom;95;148;153;98;118;124;96;95;95;95 23:44:11 INFO - PROCESS | 1976 | |7;imaging-desaturate;91;94;92;94;95;91;90;93;91;91 23:44:11 INFO - PROCESS | 1976 | |8;json-parse-financial;63;66;66;65;66;67;75;91;103;70 23:44:11 INFO - PROCESS | 1976 | |9;json-stringify-tinderbox;67;71;72;70;71;87;67;95;107;105 23:44:11 INFO - PROCESS | 1976 | |10;stanford-crypto-aes;82;82;80;84;82;83;80;80;83;99 23:44:11 INFO - PROCESS | 1976 | |11;stanford-crypto-ccm;131;131;127;132;130;131;128;140;154;179 23:44:11 INFO - PROCESS | 1976 | |12;stanford-crypto-pbkdf2;170;175;168;179;173;169;168;167;227;163 23:44:11 INFO - PROCESS | 1976 | |13;stanford-crypto-sha256-iterative;66;69;70;86;101;80;59;96;106;99 23:44:11 INFO - PROCESS | 1976 | __end_tp_report 23:44:11 INFO - PROCESS | 1976 | __start_cc_report 23:44:11 INFO - PROCESS | 1976 | _x_x_mozilla_cycle_collect,1089 23:44:11 INFO - PROCESS | 1976 | __end_cc_report 23:44:11 INFO - PROCESS | 1976 | __startTimestamp1463035451915__endTimestamp 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | ------- Summary: start ------- 23:44:11 INFO - PROCESS | 1976 | Number of tests: 14 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | [#0] ai-astar Cycles:10 Average:132.00 Median:161.00 stddev:26.98 (16.8%) stddev-sans-first:27.82 23:44:11 INFO - PROCESS | 1976 | Values: 114.0 118.0 121.0 169.0 164.0 137.0 96.0 158.0 96.0 147.0 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:149.00 stddev:15.46 (10.4%) stddev-sans-first:16.01 23:44:11 INFO - PROCESS | 1976 | Values: 149.0 122.0 155.0 155.0 120.0 133.0 129.0 149.0 159.0 123.0 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | [#2] audio-dft Cycles:10 Average:208.20 Median:200.00 stddev:24.86 (12.4%) stddev-sans-first:25.91 23:44:11 INFO - PROCESS | 1976 | Values: 195.0 196.0 200.0 195.0 196.0 222.0 275.0 206.0 197.0 200.0 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | [#3] audio-fft Cycles:10 Average:78.20 Median:66.00 stddev:27.68 (41.9%) stddev-sans-first:28.80 23:44:11 INFO - PROCESS | 1976 | Values: 63.0 71.0 81.0 143.0 56.0 58.0 69.0 72.0 110.0 59.0 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:79.50 stddev:21.91 (27.6%) stddev-sans-first:22.59 23:44:11 INFO - PROCESS | 1976 | Values: 80.0 84.0 127.0 75.0 78.0 92.0 124.0 81.0 79.0 126.0 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:87.50 stddev:19.42 (22.2%) stddev-sans-first:20.44 23:44:11 INFO - PROCESS | 1976 | Values: 88.0 87.0 88.0 85.0 88.0 77.0 134.0 128.0 88.0 85.0 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | [#6] imaging-darkroom Cycles:10 Average:111.70 Median:95.00 stddev:23.01 (24.2%) stddev-sans-first:23.60 23:44:11 INFO - PROCESS | 1976 | Values: 95.0 148.0 153.0 98.0 118.0 124.0 96.0 95.0 95.0 95.0 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | [#7] imaging-desaturate Cycles:10 Average:92.20 Median:92.50 stddev:1.69 (1.8%) stddev-sans-first:1.73 23:44:11 INFO - PROCESS | 1976 | Values: 91.0 94.0 92.0 94.0 95.0 91.0 90.0 93.0 91.0 91.0 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | [#8] json-parse-financial Cycles:10 Average:73.20 Median:66.50 stddev:13.26 (19.9%) stddev-sans-first:13.55 23:44:11 INFO - PROCESS | 1976 | Values: 63.0 66.0 66.0 65.0 66.0 67.0 75.0 91.0 103.0 70.0 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | [#9] json-stringify-tinderbox Cycles:10 Average:81.20 Median:71.00 stddev:15.91 (22.4%) stddev-sans-first:16.02 23:44:11 INFO - PROCESS | 1976 | Values: 67.0 71.0 72.0 70.0 71.0 87.0 67.0 95.0 107.0 105.0 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:82.50 stddev:5.62 (6.8%) stddev-sans-first:5.94 23:44:11 INFO - PROCESS | 1976 | Values: 82.0 82.0 80.0 84.0 82.0 83.0 80.0 80.0 83.0 99.0 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:131.50 stddev:16.36 (12.4%) stddev-sans-first:17.14 23:44:11 INFO - PROCESS | 1976 | Values: 131.0 131.0 127.0 132.0 130.0 131.0 128.0 140.0 154.0 179.0 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:171.50 stddev:18.51 (10.8%) stddev-sans-first:19.51 23:44:11 INFO - PROCESS | 1976 | Values: 170.0 175.0 168.0 179.0 173.0 169.0 168.0 167.0 227.0 163.0 23:44:11 INFO - PROCESS | 1976 | 23:44:11 INFO - PROCESS | 1976 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.20 Median:75.00 stddev:16.75 (22.3%) stddev-sans-first:16.57 23:44:11 INFO - PROCESS | 1976 | Values: 66.0 69.0 70.0 86.0 101.0 80.0 59.0 96.0 106.0 99.0 23:44:11 INFO - PROCESS | 1976 | -------- Summary: end -------- 23:44:11 INFO - PROCESS | 1976 | 23:44:12 INFO - TEST-INFO | 1976: exit 0 23:44:12 INFO - TEST-OK | kraken | took 59869ms 23:44:12 INFO - SUITE-END | took 1171s 23:44:13 INFO - Completed test suite (00:19:31) 23:44:13 INFO - javascript benchmark 23:44:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2922.4447355002553, 3287.1124796304985, 3476.2699833035067, 3511.0520159556922, 3534.982325088374, 4770.475247722748, 5760.164776107462, 5770.538356931446, 5791.623544469607, 5793.507551858092, 5736.254286942692, 5743.885122297562, 5770.480656740892, 5809.157672137548, 5813.505852002585, 4352.194843953878, 5031.924521132186, 5258.6581872178285, 5290.338707661543, 5343.904499577578, 5149.304843846089, 5278.894422111555, 5299.867503312409, 5306.893862122755, 5411.972940135293, 4308.224519586473, 5087.651772280348, 5216.76524556394, 5336.226247194155, 5351.143816989283, 4503.729776213421, 5314.096603577401, 5324.653897496651, 5324.7071411072375, 5330.706811125387, 5217.16525355945, 5243.318368612094, 5250.0, 5275.709835959021, 5400.0, 4120.896977575555, 5605.859853503654, 5647.943520564783, 5657.886842263173, 5667.773289068432, 5479.931413374394, 5797.362290148122, 6195.256569211723, 6266.686665666744, 6321.936780632181, 5630.733085055871, 5857.912131318034, 6146.985747351681, 6157.168782214389, 6263.6868156592445, 5876.559258055663, 5883.764649414018, 5887.5584331174905, 5900.793472228452, 5903.409659034105, 6348.523860710465, 6375.2668443128705, 6382.138411314413, 6383.202099737533, 6388.6166829989415, 6058.212432383762, 6133.4264757247465, 6140.140380346755, 6142.280161554771, 6157.753689852445, 6204.193454850931, 6213.37866213375, 6293.433590976834, 6304.5271604628915, 6324.936750632435, 6139.4781443577795, 6232.501399888089, 6236.18929539166, 6245.437910588069, 6265.592736472206, 6040.516758659297, 6120.508083830883, 6144.310314663414, 6208.2239720034995, 6227.501799856001, 4956.504349565014, 4971.1797553403285, 4974.676646017997, 4979.57673597741, 4980.302757613937, 3758.398656215047, 4424.557544245549, 4458.331250312479, 4470.374147619336, 4501.3022981437925, 5725.169850371756, 5823.505002074871, 5865.794697185578, 5879.882402351929, 5939.792107276225, 6203.379662033761, 6227.595206311576, 6230.937690623126, 6255.6872156392, 6262.46769024638, 5678.943210567842, 5833.329167145747, 5842.0, 5842.065269556935, 5871.0, 5442.265294185234, 5500.724963751796, 5501.14732216507, 5528.170774383874, 5552.139418390156, 6473.28793832678, 6502.707378167899, 6503.382178693017, 6506.056621789909, 6541.182352205974, 6116.396640261158, 6200.0, 6217.880781459381, 6250.468710159687, 6257.68711564429, 6341.587796793194, 6362.45919096882, 6412.006139048455, 6415.326390729093, 6432.067350234283, 6138.07928810682, 6145.385461453819, 6178.443940045418, 6232.25212974446, 6233.719482623203, 6149.41580549847, 6179.0422484514975, 6183.319834818077, 6254.124422580751, 6307.842303942438, 6051.402567140931, 6211.068339749074, 6212.471939884979, 6215.968920155551, 6269.811905642838, 5217.321748172713, 6147.139400484025, 6189.876202476015, 6194.5044396449075, 6209.0, 4661.883452913568, 5132.947745712046, 5864.296284445893, 5965.940340596539, 6002.249718785152, 6118.663473509, 6187.81436556886, 6197.752089916353, 6200.875982480416, 6226.439620434183, 6012.849678758066, 6084.402349838071, 6091.634501929899, 6107.175531303217, 6108.511319094373], "value": 5686.329771795098, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.9874503137421, 509.61269435229224, 547.5728931433483, 548.3721139295507, 581.0267801432601, 38834.0, 40627.984300392505, 40638.0, 40678.0, 40913.3862992055, 41895.790521047355, 42310.788446057726, 42705.0, 43099.78450107753, 43260.783696081475, 9512.857307140399, 9662.758431039245, 9694.66068687596, 9772.706818795448, 9818.361806482591, 9605.135537801596, 9702.320837541374, 9709.223262139047, 9716.805663886718, 9719.805603887919, 9598.088181622734, 9605.903940960607, 9652.131308182263, 9724.270679699015, 9742.0, 9573.186279166279, 9592.232621390272, 9613.807723845484, 9650.855237171449, 9716.999999999965, 9637.759056023586, 9730.36752611078, 9745.658901938468, 9775.169110625606, 9785.461799601018, 39103.41344879829, 39265.80367098146, 39301.0, 39330.0, 39482.0, 3178.55500229968, 3267.950980735267, 3337.0823023668445, 3351.078453425303, 3718.8140592970512, 20847.5830483391, 26935.461290774074, 27465.31336716578, 27534.173974780788, 27881.58177627337, 2613.46423983083, 2651.4034342273026, 2707.350235943379, 2758.9586156207674, 2865.126136528358, 405850.9707451473, 409299.0, 409527.0, 411297.0, 411738.0, 36707.63292367096, 62211.37788622056, 63218.36781632217, 63495.6825215871, 63504.68247658825, 34237.82881085579, 34804.0, 35104.29791404158, 35328.11679708028, 35426.822865886024, 15403.845961540464, 15701.607459813367, 15707.214639267992, 15717.371305147666, 15731.0, 12977.416016279101, 13039.152455090389, 13241.404136813866, 13257.403416846073, 13263.336833158304, 8079.798005049921, 8098.554579498066, 8285.917140828635, 8287.544185069879, 8433.241008309282, 3468.2716629508086, 3493.318802833423, 3507.473878918183, 3527.365074286653, 3532.3288575170636, 876.8465518534358, 885.4465958775766, 919.1773362840221, 923.2613908873009, 927.8979312275644, 26107.216783496526, 26200.475990480463, 26547.070852520454, 26554.0, 26560.46879062408, 958.434523631061, 962.2150910061874, 962.2879069488667, 1061.87257529097, 1080.287010573018, 13576.456941722417, 15779.368825246862, 15867.761983570255, 16094.597635058983, 16478.2584783685, 577484.0, 608586.0, 630201.0, 632872.8356358189, 632970.0, 64867.35132648613, 65197.0, 65224.67387663031, 65659.67170164119, 66065.66967165134, 1366.5353779714944, 1526.6107142678768, 1553.2777258574818, 1570.0344288262636, 1570.8350623184629, 30449.0, 31213.68786312108, 31287.687123129388, 31345.0, 31646.841765791945, 40377.1924561513, 48465.03069938652, 51173.720656983875, 55086.173707395224, 55331.17003245035, 457241.7137914289, 532953.0, 536266.0, 536604.0, 539101.0, 41574.792126039174, 42562.0, 43676.34485482784, 44005.33991990187, 44127.558724412345, 46280.768596156806, 46433.0, 46526.0, 48121.27818082801, 48209.75895120502, 31752.206194844388, 38297.23405531929, 38604.22791544097, 38837.41743873787, 39765.80117099396, 35553.82223088868, 35676.64323356837, 35699.286014280086, 35919.461208081375, 36035.27929441449, 32283.838580806947, 35053.47419788654, 36490.452643210905, 38286.808565958105, 38739.80630096832, 31018.914337998965, 32284.677153228167, 33426.665733343325, 33658.158546036546, 34216.97349079532, 25107.372315692253, 25185.74814251834, 25207.36981575402, 25594.232173034838, 25610.487790244464], "value": 18655.979106791037, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.9401589761537, 401.0815233116165, 403.1916008403151, 410.39671682626545, 412.1221797571174, 14726.63183420415, 19817.0, 20281.290154844566, 20545.589088218265, 20558.0748866301, 20059.799402005974, 20915.267965621206, 20948.895255523737, 21416.25043123491, 21752.347429577138, 5713.971430142843, 5740.138979153139, 5989.131575921489, 6036.637801731888, 6041.667708276043, 5006.649534532584, 5870.559708021894, 5947.464728174464, 5980.312264089642, 5990.580659353847, 5635.126555383901, 5892.0, 5926.229590153274, 5926.97036514819, 5968.582199246054, 5716.399778023331, 5753.856153596173, 5822.214001109838, 5846.736896839652, 5883.794067207627, 4791.448983366888, 5885.8822823543715, 5935.732892019826, 5937.109433584954, 5953.7320820562745, 13490.662733431645, 13609.387577559033, 14401.567952961428, 24915.0, 25040.0, 2076.007202677563, 2093.4661661276277, 2193.824494040473, 2272.659101134843, 2746.5880117982265, 9742.9512852436, 9759.756006099904, 9821.508924553744, 10147.441890696009, 10585.894141058568, 1755.8244175582468, 1851.7129844873932, 1852.6572584071855, 1853.4532312967706, 1873.3911478769319, 113988.0, 114327.0, 117504.0, 119892.0, 121834.99999999911, 11884.643460696192, 12005.0, 12073.215241009306, 12089.637310880687, 12218.327991960528, 15472.922635386976, 15499.922500387425, 15550.533483995498, 15556.22218889051, 15586.0, 9112.726618201465, 9142.314326425545, 9151.496667683208, 9153.67962121336, 9250.583723732449, 7868.859015442728, 9131.315151363675, 9157.946836113932, 9186.173244407903, 9261.0, 3985.7608543487486, 4431.1137772445, 4856.611471082305, 4863.319135321058, 4865.416150062015, 1701.4045084220672, 1731.3940120957816, 2012.7219215798073, 2050.9642630471517, 2093.6126816538685, 586.3960121075299, 760.634895250283, 761.4061032394741, 779.4738551477843, 834.2575108153748, 14602.707945841024, 17906.839651849867, 18064.0, 18091.638167236844, 18986.335478258196, 676.8307923019245, 841.2891107014563, 853.0829358439578, 868.3574155125289, 880.7709995401242, 9719.416834989923, 9748.366356186825, 9911.355761875455, 9918.40489570628, 9986.20110391167, 607452.0, 614484.0, 617089.0, 617259.0, 627341.0, 69412.0, 71466.285337147, 98200.0, 106508.0, 114080.85919140869, 926.1433174313732, 936.5317341329335, 949.4872768704822, 950.6292545907102, 1004.8995100490039, 17598.91200543989, 17806.37677681275, 17967.82032179714, 18211.089445527934, 18498.537536561693, 47718.284225735944, 47961.5203847957, 48033.519664804306, 48820.75589622029, 49927.0, 56453.30640080804, 69081.96377054248, 74684.62657686677, 76217.61891190508, 76511.23488765041, 7939.801504962422, 8263.586820658822, 8269.421140520106, 8408.411411201158, 8445.831083378422, 12082.51669933228, 12212.694682633006, 12573.811392829299, 12739.426725797546, 12973.221606703628, 8555.443896146731, 10162.695119146438, 10234.948825255826, 10277.794444110927, 10292.022257885488, 9397.248220142235, 9491.71524854228, 10140.898591013995, 10169.745756356151, 10303.175745940156, 9681.467519286507, 9997.550110245202, 10037.247206459399, 10106.494675266355, 10622.25644204929, 6807.625580593115, 7327.560346379234, 8504.107068757692, 8524.147585241675, 8812.250958668585, 8055.0, 9889.258305626963, 10523.263371564224, 10536.157107431234, 10575.682729518127], "value": 9130.66733412134, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1534.3479021415899, 1605.6226786705122, 1831.3956394389845, 1902.5624106455514, 1991.4722598511405, 7980.0, 8572.699955501559, 8654.87017694735, 8767.561621918903, 8792.472451652906, 8696.652133914651, 8765.298776097912, 8822.117788221174, 8843.955780221106, 8879.156480134394, 2410.7468715784853, 2432.5621388150125, 2433.6227884677814, 2439.4633180700307, 2443.181534186041, 2010.7486564179478, 2268.0, 2401.735809061002, 2432.0150339112597, 2449.632555116729, 2335.1243283768586, 2351.2828587280874, 2368.431576421655, 2379.143508337006, 2382.642603609464, 2420.0440825873857, 2445.596476581362, 2445.9755402446017, 2450.252672934754, 2470.7899828514596, 2430.4409985703387, 2453.129139155592, 2456.0175929628112, 2457.9877100614563, 2466.8273220874544, 9036.322275829274, 9048.457092574467, 9060.864087038633, 9064.184223419858, 9109.772255693595, 5418.566514678816, 5552.639078459887, 5554.9722251388885, 5572.219889215513, 5580.944190558123, 3542.291541691646, 3632.872849450283, 3632.963670363289, 3637.563492380905, 3694.2057457646465, 1056.3503445381111, 1078.56857257097, 1078.811208038598, 1082.4587706146926, 1083.7940791249637, 9792.629031935534, 11871.940640296743, 12266.202696824677, 12296.754064918652, 12324.75350492994, 4743.762811859393, 4783.215675402702, 4857.757112144379, 4881.438634557, 4894.828680996148, 10278.691639250685, 10344.844827327595, 10359.533820978075, 10363.896361036444, 10391.220658450646, 5409.945900541023, 5458.099413596712, 5507.173923911445, 5521.950829342492, 5522.861928451821, 4447.533009034069, 4813.470518242991, 4878.121938051185, 4892.217245240816, 4916.139675556763, 3709.8330575124182, 4063.837446502166, 4124.05146816234, 4182.226288136704, 4211.873643790691, 1334.759743246225, 1354.5733094075335, 1359.5989183190982, 1365.1058556645414, 1369.349558959506, 853.2022558907441, 872.6204101215991, 892.2214421923151, 899.3479727197729, 913.8583519554479, 5432.837014889559, 5623.044082505902, 5664.54683625309, 5711.314642242957, 5876.059830427112, 911.7128104647015, 914.3782228084966, 948.3598570964709, 949.7435692363023, 959.8704174936433, 3580.856765729394, 3592.4611308303965, 3652.726045546595, 3678.2275722098657, 3682.4844521766972, 10419.905909879353, 10673.83989240162, 10870.836937445945, 10992.560297588007, 11065.170112241614, 10601.0, 10730.19523535738, 10766.354018758899, 10893.83659245112, 10895.673129806119, 8374.581270936429, 8477.364197685198, 8482.448640838325, 8540.53027083504, 8551.315894728406, 5249.895002100013, 5390.245365648891, 5447.319085114361, 5476.972615136899, 5492.0, 9350.485723285285, 9534.904650953402, 9706.126448619658, 9720.027997200223, 9723.270754693285, 9752.171065459515, 10040.347377420445, 10042.0, 10184.898151018395, 10186.981301869753, 6887.139107611549, 7193.0, 7351.117865856131, 7470.514416562906, 7545.50954187976, 8386.958065209636, 8392.0, 8438.789030274293, 8454.239118479367, 8458.830823383621, 7296.343329100407, 7305.452091093083, 7449.106107267163, 7532.13380461232, 7578.242175782378, 7228.20489746117, 7305.2329505403295, 7335.926640733524, 7406.481546291708, 7408.111026676834, 6806.387425131762, 6845.110135682329, 6867.244603093755, 6874.106366172366, 6885.1049363582415, 4620.3993480847275, 4633.559811817872, 4659.836905708419, 4751.0, 4756.025014871874, 4661.324108004253, 4676.929846052244, 4702.882427939329, 4707.599854012447, 4721.362616046789], "value": 4611.025345792252, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [257.74734788925815, 272.9194887508184, 308.51255017073044, 321.6976042520031, 322.0708256679479, 6168.660723660197, 6675.66621668917, 6724.630145342005, 6744.325567443259, 6765.391114799667, 5392.541633961118, 6646.136002319704, 6657.467402607792, 6745.325467453252, 6777.695003724832, 4936.531029552187, 4969.981153863449, 4983.152864013126, 4990.05189014088, 4995.650304478688, 4973.776180071905, 4997.075541024904, 4998.0, 5004.224345226477, 5018.974905125469, 4014.1770936958, 4533.7053091549105, 4692.741899195543, 4943.233798761198, 4959.280904268879, 4775.259834725588, 4929.309896614477, 4947.307376967227, 4963.0, 4966.15575352191, 4198.958010419918, 4227.365895115727, 4233.491980962273, 4249.893752656209, 4257.212415703074, 5141.640085194038, 6482.805515834532, 6494.058361537551, 6496.382843629847, 6509.251436084864, 5830.358660547379, 5883.029300165467, 5887.264091988502, 5900.704964751745, 5901.114832775118, 7217.350438460511, 7222.09723784527, 7252.274772522758, 7258.693435181665, 7266.237045110241, 4606.838760643395, 4664.626829853603, 4747.881302967419, 4758.238681810928, 4761.6190704743885, 7617.542947423117, 7679.0, 7706.306432421053, 7714.421418393643, 7727.38180945523, 4812.590929771009, 4827.662063655511, 4827.951720482821, 4829.396325459317, 4838.225883858636, 4905.117078925828, 4914.0908931847725, 4929.334539837076, 4934.358533390637, 4944.307796908436, 5858.619189752652, 5862.3585396089165, 5869.119632055226, 5875.383084776123, 5876.529877609781, 5795.9420405796245, 5811.854703632443, 6957.130358705162, 7245.746398876014, 7353.742619008309, 1644.9506514804575, 1654.139847279432, 1670.941517046922, 1673.548142001677, 1675.631361100556, 1040.386172158415, 1040.9167266618651, 1062.7290041039485, 1064.1965316186383, 1066.9466526673634, 6509.0, 6583.44040756541, 6784.966075169691, 6785.287544807823, 6814.046033555306, 6895.275996020446, 7596.886046709304, 7624.2464233226665, 7644.694212231449, 7654.540727556365, 6751.493637977172, 6755.527113102035, 6777.762778302736, 6781.796546103625, 6813.420859226922, 4005.178938317638, 4021.4571032910185, 4028.113814960704, 4038.2529232092156, 4044.4742183515955, 7640.312371886557, 7922.445428819928, 7927.4054445915635, 8001.279884810395, 8013.759587212393, 7829.0, 7894.447388682852, 7907.367410607138, 7915.366770658334, 7958.3235424989525, 6521.8695626088165, 7425.848993406031, 7986.680532778624, 8012.599370031475, 8019.997500312461, 6448.548601597843, 7302.3792977597495, 7616.619169041636, 7622.123455802654, 7624.313811756969, 7515.2109028553405, 7520.00719809262, 7521.0, 7549.433792465477, 7555.6977720890545, 7979.045133941989, 8014.919850801417, 8026.558539280162, 8055.395845311742, 8102.7569172924905, 3924.862629807943, 4639.257718764981, 4710.764461776829, 4722.976385118052, 4739.644526660445, 6152.876942461036, 7231.674574644258, 7524.984127142766, 7576.24237576238, 7702.653380597774, 7251.0, 7305.0, 7306.41548676094, 7349.375303099083, 7377.741779037708, 5938.851528711644, 7307.378872795872, 7308.780736577911, 7327.487075904635, 7352.375048120755, 5771.336296325976, 7125.966734823525, 7157.85684286301, 7178.497505174588, 7202.551132614936, 5823.563232757645, 7187.993680884785, 7270.636468176675, 7321.963390183015, 7323.523970942085, 6833.453323734188, 7022.367986881205, 7088.681009354695, 7090.929090709027, 7141.678624462015], "value": 5239.113732921507, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.747953339131, 682.2699711308901, 740.8296091898864, 750.3359526818764, 754.4304050441915, 14562.563123106298, 14590.854091459083, 14695.265236738174, 14703.926480367596, 14828.6292842679, 13611.863881361209, 13622.659433514167, 13636.113652612574, 13637.659058523517, 13649.839763620104, 722.9313215244543, 887.6183241206279, 901.2519608724742, 918.4305730447098, 920.3051695969534, 905.1446383167909, 915.8626206069109, 918.4030380252856, 918.9586468608928, 922.4280945813605, 960.8558716192592, 964.3490643815431, 964.5273815830228, 965.9758506037335, 967.7145242153547, 918.8575770755577, 919.3426699909596, 920.3741455810047, 935.7707361696359, 957.7366224288342, 700.3696672994295, 707.85135121624, 708.6633848921772, 711.2602892991283, 714.0003994407818, 12143.757124857542, 14619.561413157622, 14622.049566778125, 14642.487512937103, 14676.779848302178, 12499.56251531192, 12539.874601254052, 12593.37033148339, 12647.17793343439, 12796.232226066373, 9938.062077894814, 9952.253580981383, 10224.437655928921, 10284.43435611041, 10312.793744125076, 3480.796209666539, 3487.424574945131, 3510.4909788080586, 3561.71506279497, 3743.9812800936093, 74219.0, 74565.25434745637, 74567.0, 74629.62685186593, 75753.62123189404, 8740.169683880022, 8796.34027447944, 9663.13031827139, 9684.273679474067, 9773.31586788918, 21515.462113447287, 21592.784072159393, 21601.0, 21601.351959441243, 21624.675629865564, 7509.324160825552, 7538.020057392504, 7580.583067931207, 7607.125180604191, 7839.216078392229, 4129.009037830899, 4191.7694526801315, 4192.203481338536, 4197.538270790211, 4202.2646036943415, 3579.6599323064265, 3638.799866007342, 3654.086478380405, 3659.451082337617, 3664.4686520454384, 647.3591144766741, 656.2485953583121, 669.4142625202948, 675.2336098528206, 675.6419097878132, 533.168257518265, 566.9461401166883, 571.0178492992047, 581.8894410062074, 625.6246252248615, 7350.4119670426235, 7688.730894418669, 7708.768736937901, 7714.614269286513, 7727.459077864608, 520.0119772432408, 526.7971830845153, 554.938956714761, 573.3206150711337, 598.3328588623654, 3473.7221022318154, 3607.6572725591027, 3657.122290650278, 3702.4631428443263, 3902.707296952683, 83873.58063209767, 89725.55137224273, 89840.5507972469, 90592.54703726571, 91336.543317283, 73904.63047684835, 74414.62792686002, 74997.0, 75030.12424689427, 75663.0, 68254.0, 69540.30459695339, 70326.9450958236, 70952.64523677349, 71108.86673399806, 8177.632006559838, 8200.917990820015, 8273.586320684062, 8450.873236901329, 8543.0572682385, 46400.8399790008, 46773.53226467828, 46788.59634210979, 47664.52335476739, 47908.5209147904, 58108.41891581199, 58810.11784823317, 60588.39411606004, 60740.0, 61808.0, 8654.394192406471, 10630.73423164427, 10779.13766898662, 10995.835062473909, 11371.0, 9229.584668690059, 11443.485043173243, 11882.227655202385, 11887.395141950268, 12105.334206618369, 11178.217524773188, 11309.390254239257, 11408.315501069963, 11669.76660466803, 11698.4735686896, 11412.201145919706, 11494.885051149382, 11508.13688973347, 11615.303081815118, 11664.558033890902, 11055.889441105486, 11060.557577697124, 11136.888631113585, 11536.94231528837, 11656.368108464652, 9522.571484283362, 9724.70825875225, 9735.707928761865, 9805.28199419973, 9956.850647240442, 9591.616335346507, 9653.951730241304, 9708.902910971083, 9796.314258001872, 9816.0], "value": 6791.401325120221, "unit": "score"}], "name": "dromaeo_css", "value": 7359.81539030343, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 121.0, 169.0, 164.0, 137.0, 96.0, 158.0, 96.0, 147.0], "value": 132.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 155.0, 155.0, 120.0, 133.0, 129.0, 149.0, 159.0, 123.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 196.0, 200.0, 195.0, 196.0, 222.0, 275.0, 206.0, 197.0, 200.0], "value": 208.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 81.0, 143.0, 56.0, 58.0, 69.0, 72.0, 110.0, 59.0], "value": 78.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 127.0, 75.0, 78.0, 92.0, 124.0, 81.0, 79.0, 126.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 85.0, 88.0, 77.0, 134.0, 128.0, 88.0, 85.0], "value": 94.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 148.0, 153.0, 98.0, 118.0, 124.0, 96.0, 95.0, 95.0, 95.0], "value": 111.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 92.0, 94.0, 95.0, 91.0, 90.0, 93.0, 91.0, 91.0], "value": 92.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 66.0, 65.0, 66.0, 67.0, 75.0, 91.0, 103.0, 70.0], "value": 73.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 72.0, 70.0, 71.0, 87.0, 67.0, 95.0, 107.0, 105.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 80.0, 84.0, 82.0, 83.0, 80.0, 80.0, 83.0, 99.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 127.0, 132.0, 130.0, 131.0, 128.0, 140.0, 154.0, 179.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 175.0, 168.0, 179.0, 173.0, 169.0, 168.0, 167.0, 227.0, 163.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 70.0, 86.0, 101.0, 80.0, 59.0, 96.0, 106.0, 99.0], "value": 83.2, "unit": "score"}], "name": "kraken", "value": 1586.4, "alertThreshold": 2.0}]} 23:44:13 INFO - Return code: 0 23:44:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:44:13 ERROR - # TBPL SUCCESS # 23:44:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:44:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:44:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:44:13 INFO - 2016-05-11 23:44:13.175 screenresolution[1981:23035] starting screenresolution argv=screenresolution get 23:44:13 INFO - 2016-05-11 23:44:13.178 screenresolution[1981:23035] Display 0: 1600x1200x32@60 23:44:13 INFO - 2016-05-11 23:44:13.184 screenresolution[1982:23038] starting screenresolution argv=screenresolution list 23:44:13 INFO - Available Modes on Display 0 23:44:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:44:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:44:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:44:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:44:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:44:13 INFO - Intel Iris: 23:44:13 INFO - Chipset Model: Intel Iris 23:44:13 INFO - Type: GPU 23:44:13 INFO - Bus: Built-In 23:44:13 INFO - VRAM (Dynamic, Max): 1536 MB 23:44:13 INFO - Vendor: Intel (0x8086) 23:44:13 INFO - Device ID: 0x0a2e 23:44:13 INFO - Revision ID: 0x0009 23:44:13 INFO - Displays: 23:44:13 INFO - Display: 23:44:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:44:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:44:13 INFO - Display Serial Number: 1600x1200 60 23:44:13 INFO - Main Display: Yes 23:44:13 INFO - Mirror: Off 23:44:13 INFO - Online: Yes 23:44:13 INFO - Rotation: Supported 23:44:13 INFO - Return code: 0 23:44:13 INFO - Running post-action listener: _resource_record_post_action 23:44:13 INFO - Running post-run listener: _resource_record_post_run 23:44:14 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 32768; Write bytes: 657849344; Read time: 1; Write time: 2005 23:44:14 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 346503680; Write bytes: 345282048; Read time: 26505; Write time: 612 23:44:14 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 32768; Write bytes: 302609920; Read time: 1; Write time: 1358 23:44:14 INFO - Running post-run listener: _upload_blobber_files 23:44:14 INFO - Blob upload gear active. 23:44:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:44:14 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 23:44:14 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'] 23:44:14 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 23:44:14 INFO - (blobuploader) - INFO - Open directory for files ... 23:44:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:44:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:44:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:15 INFO - (blobuploader) - INFO - Done attempting. 23:44:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:44:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:44:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:16 INFO - (blobuploader) - INFO - Done attempting. 23:44:16 INFO - (blobuploader) - INFO - Iteration through files over. 23:44:16 INFO - Return code: 0 23:44:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:44:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:44:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd17b3da3cc3d9c4aa554cd21ace45243846b2e835f2f0b5a271bd69dce4b7de9c7e08c2fe90d3f524a0cf69a87dbf7e70531bfdf59c7945f1295bb665ea8ece", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b01e3195bc52e335e766f1d16f804abe4a229e7ebf208cdd4c8862a277e6af979ffbd06086196f3d43b5ff6a2d3df2ff016f2c6d22c0c5ef7e8a8e222ca3d006"} 23:44:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:44:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:44:16 INFO - Contents: 23:44:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd17b3da3cc3d9c4aa554cd21ace45243846b2e835f2f0b5a271bd69dce4b7de9c7e08c2fe90d3f524a0cf69a87dbf7e70531bfdf59c7945f1295bb665ea8ece", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b01e3195bc52e335e766f1d16f804abe4a229e7ebf208cdd4c8862a277e6af979ffbd06086196f3d43b5ff6a2d3df2ff016f2c6d22c0c5ef7e8a8e222ca3d006"} 23:44:16 INFO - Running post-run listener: copy_logs_to_upload_dir 23:44:16 INFO - Copying logs to upload dir... 23:44:16 INFO - mkdir: /builds/slave/test/build/upload/logs 23:44:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.498086 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-11 23:44:16.576989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 23:44:16.580968) ========= 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.fp6ou6qQxq/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.xI3CIXPRnc/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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/dd17b3da3cc3d9c4aa554cd21ace45243846b2e835f2f0b5a271bd69dce4b7de9c7e08c2fe90d3f524a0cf69a87dbf7e70531bfdf59c7945f1295bb665ea8ece", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b01e3195bc52e335e766f1d16f804abe4a229e7ebf208cdd4c8862a277e6af979ffbd06086196f3d43b5ff6a2d3df2ff016f2c6d22c0c5ef7e8a8e222ca3d006"} build_url:https://queue.taskcluster.net/v1/task/a5swiOwTRgGHPLsEeXd3Ag/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011078 build_url: 'https://queue.taskcluster.net/v1/task/a5swiOwTRgGHPLsEeXd3Ag/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/dd17b3da3cc3d9c4aa554cd21ace45243846b2e835f2f0b5a271bd69dce4b7de9c7e08c2fe90d3f524a0cf69a87dbf7e70531bfdf59c7945f1295bb665ea8ece", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b01e3195bc52e335e766f1d16f804abe4a229e7ebf208cdd4c8862a277e6af979ffbd06086196f3d43b5ff6a2d3df2ff016f2c6d22c0c5ef7e8a8e222ca3d006"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 23:44:16.611632) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:44:16.612302) ========= 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.fp6ou6qQxq/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.xI3CIXPRnc/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.005151 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:44:16.664750) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 23:44:16.665606) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 23:44:16.666263) ========= ========= Total master_lag: 1.92 =========