Back to build
Raw log | Switch to full mode | Login

{ "shards": [ { "bot_dimensions": [ { "key": "caches", "value": [ "swarming_module_cache_vpython", "xcode_ios_10b61", "xcode_ios_10o45e" ] }, { "key": "cores", "value": [ "4" ] }, { "key": "cpu", "value": [ "x86", "x86-64", "x86-64-i7-4578U" ] }, { "key": "gce", "value": [ "0" ] }, { "key": "gpu", "value": [ "8086", "8086:0a2e" ] }, { "key": "hidpi", "value": [ "0" ] }, { "key": "id", "value": [ "build305-h9" ] }, { "key": "mac_model", "value": [ "Macmini7,1" ] }, { "key": "machine_type", "value": [ "n1-standard-4" ] }, { "key": "os", "value": [ "Mac", "Mac-10.14", "Mac-10.14.4" ] }, { "key": "pool", "value": [ "Chrome" ] }, { "key": "python", "value": [ "2.7.10" ] }, { "key": "server_version", "value": [ "4303-bae210e" ] }, { "key": "ssd", "value": [ "1" ] }, { "key": "zone", "value": [ "us", "us-iad", "us-iad-golo", "us-iad-golo-h9" ] } ], "bot_id": "build305-h9", "bot_version": "ec327ca04645110c43b092f9eb2d259c2461902ca791b7bcf390931d49bda575", "cipd_pins": { "client_package": { "package_name": "infra/tools/cipd/mac-amd64", "version": "1vQ99wQk82cRyVYu18rqMpXtb7XZ3WHvL3HFXTcLHN4C" }, "packages": [ { "package_name": "infra/tools/mac_toolchain/mac-amd64", "path": ".", "version": "1065f97353165dfafa89b64bfdaf9b424d705bc7" }, { "package_name": "infra/python/cpython/mac-amd64", "path": ".swarming_module", "version": "6dd10e31dc5d4cbb3c8f42a6fbd9485aeeb9ef0c" }, { "package_name": "infra/tools/luci/logdog/butler/mac-amd64", "path": ".swarming_module", "version": "3138aa2054ab30eac6f7e1e589e590571ae44692" }, { "package_name": "infra/tools/luci/vpython-native/mac-amd64", "path": ".swarming_module", "version": "QDLPZ3UAgZNoR5d69kckoahXHUl1oKiq5UVzhbr3X4EC" }, { "package_name": "infra/tools/luci/vpython/mac-amd64", "path": ".swarming_module", "version": "up_SZsefNVjCYV99Mh2FddLgkRCR_FxXo_Qn2bhROIsC" } ] }, "completed_ts": "2019-05-25T16:03:58.837331", "costs_usd": [ 0.1223105652779604 ], "created_ts": "2019-05-25T15:48:53.039279", "duration": 856.9050509929657, "modified_ts": "2019-05-25T16:03:58.837331", "name": "ios_chrome_web_egtests (iPhone X iOS 11.4) (with patch)/Mac-10.13.6/c34b66d09c/ios-simulator-full-configs/14991", "output": "[I 2019-05-25 08:49:08] About to install Xcode 10b61 in Xcode.app for ios\n[08:49:09:INFO] Using Xcode version 10.1 build 10B61 at /b/s/w/ir/Xcode.app/Contents/Developer\n[08:49:09:INFO] Killing simulators.\nDevice wiped.\n[08:49:17:DEBUG] Setting sigterm handler.\n[08:49:19:INFO] User defaults from command line:\n[08:49:19:INFO] IDETestRunSpecificationPath = /var/folders/2j/22s2gz0s7hn48k32d47clxf80000gm/T/9B7FE8D5-9816-4BDA-9002-59FFFA81D0F8\n[08:49:19:INFO] \n[08:49:19:INFO] Testing started on 'iPhone X'\n[08:49:19:INFO] 2019-05-25 08:49:19.311 xcodebuild[12215:105969] IDETestOperationsObserverDebug: Writing diagnostic log for test session to:\n[08:49:19:INFO] /Users/chrome-bot/Library/Developer/Xcode/DerivedData/temporary-gkwagkzyztadmtakdugkpybnftel/Logs/Test/Test-Transient Testing-2019.05.25_08-49-19--0700.xcresult/1_Test/Diagnostics/ios_chrome_web_egtests_module-DACEB635-8293-4416-A381-50A3F01B8A1F/ios_chrome_web_egtests_module-640422F8-E144-4887-899E-7EB3A79BCD96/Session-ios_chrome_web_egtests_module-2019-05-25_084919-jmx99d.log\n[08:49:19:INFO] 2019-05-25 08:49:19.312 xcodebuild[12215:105947] [MT] IDETestOperationsObserverDebug: (BFE0EA1D-56DE-4724-BF8B-6D2951500223) Beginning test session ios_chrome_web_egtests_module-BFE0EA1D-56DE-4724-BF8B-6D2951500223 at 2019-05-25 08:49:19.312 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7ff81c9623e0> {\n[08:49:19:INFO] \t\tSimDevice: iPhone X (DDC43D1E-E47D-4EA1-8054-3287A6ED7E3A, iOS 11.4, Shutdown)\n[08:49:19:INFO] } (11.4 (15F79))\n[08:49:48:INFO] 2019-05-25 08:49:48.693 ios_chrome_web_egtests[12336:107276] Crash handler setup started.\n[08:49:48:INFO] 2019-05-25 08:49:48.694 ios_chrome_web_egtests[12336:107276] Crash handler setup completed.\n[08:49:48:INFO] 2019-05-25 08:49:48.694 ios_chrome_web_egtests[12336:107276] Enabling accessibility for automation on Simulator.\n[08:49:48:INFO] objc[12336]: Class VCWeakObjectHolder is implemented in both /b/s/w/ir/Xcode.app/Contents/Developer/Platforms/iPhoneOS.platform/Developer/Library/CoreSimulator/Profiles/Runtimes/iOS 11.4.simruntime/Contents/Resources/RuntimeRoot/System/Library/PrivateFrameworks/AVConference.framework/Frameworks/ViceroyTrace.framework/ViceroyTrace (0x14805c4d0) and /b/s/w/ir/Xcode.app/Contents/Developer/Platforms/iPhoneOS.platform/Developer/Library/CoreSimulator/Profiles/Runtimes/iOS 11.4.simruntime/Contents/Resources/RuntimeRoot/System/Library/PrivateFrameworks/AVConference.framework/AVConference (0x147e72e38). One of the two will be used. Which one is undefined.\n[08:49:50:INFO] 2019-05-25 08:49:50.458 ios_chrome_web_egtests[12336:107276] could not create directory \"\" for future sandbox extension, error Error Domain=NSCocoaErrorDomain Code=512 \"The file \u201c\u201d couldn\u2019t be saved.\" UserInfo={NSFilePath=}\n[08:49:50:INFO] 2019-05-25 08:49:50.458 ios_chrome_web_egtests[12336:107276] could not create directory \"\" for future sandbox extension, error Error Domain=NSCocoaErrorDomain Code=512 \"The file \u201c\u201d couldn\u2019t be saved.\" UserInfo={NSFilePath=}\n[08:49:50:INFO] 2019-05-25 08:49:50.459 ios_chrome_web_egtests[12336:107276] could not create directory \"\" for future sandbox extension, error Error Domain=NSCocoaErrorDomain Code=512 \"The file \u201c\u201d couldn\u2019t be saved.\" UserInfo={NSFilePath=}\n[08:49:50:INFO] 2019-05-25 08:49:50.459 ios_chrome_web_egtests[12336:107276] could not create directory \"\" for future sandbox extension, error Error Domain=NSCocoaErrorDomain Code=512 \"The file \u201c\u201d couldn\u2019t be saved.\" UserInfo={NSFilePath=}\n[08:49:51:INFO] 2019-05-25 08:49:51.354 ios_chrome_web_egtests[12336:107276] Unbalanced calls to begin/end appearance transitions for <TabGridViewController: 0x7f8f0c0b8e00>.\n[08:49:52:INFO] [0525/084952.136136:ERROR:send_tab_to_self_client_service_ios.mm(120)] Not implemented reached in virtual void send_tab_to_self::SendTabToSelfClientServiceIOS::EntriesRemovedRemotely(const std::vector<std::string> &)\n[08:49:53:INFO] [0525/084953.021772:WARNING:leveldb_database.cc(106)] Unable to open /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/DDC43D1E-E47D-4EA1-8054-3287A6ED7E3A/data/Containers/Data/Application/5EDE4370-6354-4DBB-BB3C-6C80037633FC/Library/Application Support/Chromium/Default/shared_proto_db: Invalid argument: /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/DDC43D1E-E47D-4EA1-8054-3287A6ED7E3A/data/Containers/Data/Application/5EDE4370-6354-4DBB-BB3C-6C80037633FC/Library/Application Support/Chromium/Default/shared_proto_db: does not exist (create_if_missing is false)\n[08:49:58:INFO] Test Suite 'All tests' started at 2019-05-25 08:49:58.835\n[08:49:58:INFO] Test Suite 'ios_chrome_web_egtests.app' started at 2019-05-25 08:49:58.836\n[08:49:58:INFO] Test Suite 'BrowsingPreventDefaultTestCase' started at 2019-05-25 08:49:58.836\n[08:49:58:INFO] [0525/084958.844944:WARNING:loopback_server.cc(835)] Loopback sync persistent state file does not exist.\n[08:50:00:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesStopPropagation]' started.\n[08:50:03:INFO] [0525/085003.051346:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:50:06:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesStopPropagation]' passed (5.544 seconds).\n[08:50:06:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesTargetBlank]' started.\n[08:50:11:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesTargetBlank]' passed (4.998 seconds).\n[08:50:11:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesWindowOpen]' started.\n[08:50:17:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesWindowOpen]' passed (6.099 seconds).\n[08:50:17:INFO] Test Suite 'BrowsingPreventDefaultTestCase' passed at 2019-05-25 08:50:17.363.\n[08:50:17:INFO] \t Executed 3 tests, with 0 failures (0 unexpected) in 16.641 (18.527) seconds\n[08:50:17:INFO] Test Suite 'BrowsingTestCase' started at 2019-05-25 08:50:17.364\n[08:50:17:INFO] [0525/085017.364861:WARNING:loopback_server.cc(835)] Loopback sync persistent state file does not exist.\n[08:50:17:INFO] Test Case '-[BrowsingTestCase testBrowsingJavaScriptBasedNavigation]' started.\n[08:50:19:INFO] [0525/085019.455521:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:50:24:INFO] Test Case '-[BrowsingTestCase testBrowsingJavaScriptBasedNavigation]' passed (7.103 seconds).\n[08:50:24:INFO] Test Case '-[BrowsingTestCase testBrowsingStopPropagation]' started.\n[08:50:30:INFO] Test Case '-[BrowsingTestCase testBrowsingStopPropagation]' passed (6.098 seconds).\n[08:50:30:INFO] Test Case '-[BrowsingTestCase testBrowsingStopPropagationRelativePath]' started.\n[08:50:36:INFO] Test Case '-[BrowsingTestCase testBrowsingStopPropagationRelativePath]' passed (6.005 seconds).\n[08:50:36:INFO] Test Case '-[BrowsingTestCase testBrowsingTabTitleSetFromScript]' started.\n[08:50:38:INFO] 2019-05-25 08:50:38.379 ios_chrome_web_egtests[12336:107276] -- Earl Grey Test Skipped -- Tab Title not displayed on handset.\n[08:50:40:INFO] Test Case '-[BrowsingTestCase testBrowsingTabTitleSetFromScript]' passed (3.693 seconds).\n[08:50:40:INFO] Test Case '-[BrowsingTestCase testBrowsingTabTitleSetFromURL]' started.\n[08:50:42:INFO] 2019-05-25 08:50:42.084 ios_chrome_web_egtests[12336:107276] -- Earl Grey Test Skipped -- Tab Title not displayed on handset.\n[08:50:43:INFO] Test Case '-[BrowsingTestCase testBrowsingTabTitleSetFromURL]' passed (3.694 seconds).\n[08:50:43:INFO] Test Case '-[BrowsingTestCase testBrowsingUserJavaScriptNavigation]' started.\n[08:50:48:INFO] 2019-05-25 08:50:48.641 ios_chrome_web_egtests[12336:107276] Attempting to type key j.\n[08:50:48:INFO] 2019-05-25 08:50:48.645 ios_chrome_web_egtests[12336:107276] Tapping on key: j.\n[08:50:48:INFO] 2019-05-25 08:50:48.752 ios_chrome_web_egtests[12336:107276] Attempting to type key a.\n[08:50:48:INFO] 2019-05-25 08:50:48.753 ios_chrome_web_egtests[12336:107276] Tapping on key: a.\n[08:50:48:INFO] 2019-05-25 08:50:48.826 ios_chrome_web_egtests[12336:107276] Attempting to type key v.\n[08:50:48:INFO] 2019-05-25 08:50:48.828 ios_chrome_web_egtests[12336:107276] Tapping on key: v.\n[08:50:48:INFO] 2019-05-25 08:50:48.887 ios_chrome_web_egtests[12336:107276] Attempting to type key a.\n[08:50:48:INFO] 2019-05-25 08:50:48.887 ios_chrome_web_egtests[12336:107276] Tapping on key: a.\n[08:50:48:INFO] 2019-05-25 08:50:48.943 ios_chrome_web_egtests[12336:107276] Attempting to type key s.\n[08:50:48:INFO] 2019-05-25 08:50:48.944 ios_chrome_web_egtests[12336:107276] Tapping on key: s.\n[08:50:48:INFO] 2019-05-25 08:50:48.996 ios_chrome_web_egtests[12336:107276] Attempting to type key c.\n[08:50:48:INFO] 2019-05-25 08:50:48.997 ios_chrome_web_egtests[12336:107276] Tapping on key: c.\n[08:50:49:INFO] 2019-05-25 08:50:49.049 ios_chrome_web_egtests[12336:107276] Attempting to type key r.\n[08:50:49:INFO] 2019-05-25 08:50:49.049 ios_chrome_web_egtests[12336:107276] Tapping on key: r.\n[08:50:49:INFO] 2019-05-25 08:50:49.101 ios_chrome_web_egtests[12336:107276] Attempting to type key i.\n[08:50:49:INFO] 2019-05-25 08:50:49.102 ios_chrome_web_egtests[12336:107276] Tapping on key: i.\n[08:50:49:INFO] 2019-05-25 08:50:49.155 ios_chrome_web_egtests[12336:107276] Attempting to type key p.\n[08:50:49:INFO] 2019-05-25 08:50:49.155 ios_chrome_web_egtests[12336:107276] Tapping on key: p.\n[08:50:49:INFO] 2019-05-25 08:50:49.208 ios_chrome_web_egtests[12336:107276] Attempting to type key t.\n[08:50:49:INFO] 2019-05-25 08:50:49.209 ios_chrome_web_egtests[12336:107276] Tapping on key: t.\n[08:50:49:INFO] 2019-05-25 08:50:49.264 ios_chrome_web_egtests[12336:107276] Attempting to type key :.\n[08:50:49:INFO] 2019-05-25 08:50:49.369 ios_chrome_web_egtests[12336:107276] Tapping on key: more, numbers.\n[08:50:49:INFO] 2019-05-25 08:50:49.437 ios_chrome_web_egtests[12336:107276] Tapping on key: :.\n[08:50:49:INFO] 2019-05-25 08:50:49.506 ios_chrome_web_egtests[12336:107276] Attempting to type key w.\n[08:50:49:INFO] 2019-05-25 08:50:49.813 ios_chrome_web_egtests[12336:107276] Tapping on key: more, letters.\n[08:50:49:INFO] 2019-05-25 08:50:49.866 ios_chrome_web_egtests[12336:107276] Tapping on key: w.\n[08:50:49:INFO] 2019-05-25 08:50:49.923 ios_chrome_web_egtests[12336:107276] Attempting to type key i.\n[08:50:49:INFO] 2019-05-25 08:50:49.923 ios_chrome_web_egtests[12336:107276] Tapping on key: i.\n[08:50:49:INFO] 2019-05-25 08:50:49.979 ios_chrome_web_egtests[12336:107276] Attempting to type key n.\n[08:50:49:INFO] 2019-05-25 08:50:49.981 ios_chrome_web_egtests[12336:107276] Tapping on key: n.\n[08:50:50:INFO] 2019-05-25 08:50:50.037 ios_chrome_web_egtests[12336:107276] Attempting to type key d.\n[08:50:50:INFO] 2019-05-25 08:50:50.038 ios_chrome_web_egtests[12336:107276] Tapping on key: d.\n[08:50:50:INFO] 2019-05-25 08:50:50.091 ios_chrome_web_egtests[12336:107276] Attempting to type key o.\n[08:50:50:INFO] 2019-05-25 08:50:50.092 ios_chrome_web_egtests[12336:107276] Tapping on key: o.\n[08:50:50:INFO] 2019-05-25 08:50:50.145 ios_chrome_web_egtests[12336:107276] Attempting to type key w.\n[08:50:50:INFO] 2019-05-25 08:50:50.145 ios_chrome_web_egtests[12336:107276] Tapping on key: w.\n[08:50:50:INFO] 2019-05-25 08:50:50.199 ios_chrome_web_egtests[12336:107276] Attempting to type key ..\n[08:50:50:INFO] 2019-05-25 08:50:50.200 ios_chrome_web_egtests[12336:107276] Tapping on key: ..\n[08:50:50:INFO] 2019-05-25 08:50:50.264 ios_chrome_web_egtests[12336:107276] Attempting to type key l.\n[08:50:50:INFO] 2019-05-25 08:50:50.265 ios_chrome_web_egtests[12336:107276] Tapping on key: l.\n[08:50:50:INFO] 2019-05-25 08:50:50.321 ios_chrome_web_egtests[12336:107276] Attempting to type key o.\n[08:50:50:INFO] 2019-05-25 08:50:50.321 ios_chrome_web_egtests[12336:107276] Tapping on key: o.\n[08:50:50:INFO] 2019-05-25 08:50:50.377 ios_chrome_web_egtests[12336:107276] Attempting to type key c.\n[08:50:50:INFO] 2019-05-25 08:50:50.378 ios_chrome_web_egtests[12336:107276] Tapping on key: c.\n[08:50:50:INFO] 2019-05-25 08:50:50.432 ios_chrome_web_egtests[12336:107276] Attempting to type key a.\n[08:50:50:INFO] 2019-05-25 08:50:50.432 ios_chrome_web_egtests[12336:107276] Tapping on key: a.\n[08:50:50:INFO] 2019-05-25 08:50:50.486 ios_chrome_web_egtests[12336:107276] Attempting to type key t.\n[08:50:50:INFO] 2019-05-25 08:50:50.486 ios_chrome_web_egtests[12336:107276] Tapping on key: t.\n[08:50:50:INFO] 2019-05-25 08:50:50.541 ios_chrome_web_egtests[12336:107276] Attempting to type key i.\n[08:50:50:INFO] 2019-05-25 08:50:50.542 ios_chrome_web_egtests[12336:107276] Tapping on key: i.\n[08:50:50:INFO] 2019-05-25 08:50:50.597 ios_chrome_web_egtests[12336:107276] Attempting to type key o.\n[08:50:50:INFO] 2019-05-25 08:50:50.598 ios_chrome_web_egtests[12336:107276] Tapping on key: o.\n[08:50:50:INFO] 2019-05-25 08:50:50.651 ios_chrome_web_egtests[12336:107276] Attempting to type key n.\n[08:50:50:INFO] 2019-05-25 08:50:50.652 ios_chrome_web_egtests[12336:107276] Tapping on key: n.\n[08:50:50:INFO] 2019-05-25 08:50:50.703 ios_chrome_web_egtests[12336:107276] Attempting to type key =.\n[08:50:50:INFO] 2019-05-25 08:50:50.807 ios_chrome_web_egtests[12336:107276] Tapping on key: more, numbers.\n[08:50:50:INFO] 2019-05-25 08:50:50.960 ios_chrome_web_egtests[12336:107276] Tapping on key: more, symbols.\n[08:50:51:INFO] 2019-05-25 08:50:51.030 ios_chrome_web_egtests[12336:107276] Tapping on key: =.\n[08:50:51:INFO] 2019-05-25 08:50:51.086 ios_chrome_web_egtests[12336:107276] Attempting to type key '.\n[08:50:51:INFO] 2019-05-25 08:50:51.088 ios_chrome_web_egtests[12336:107276] Tapping on key: '.\n[08:50:51:INFO] 2019-05-25 08:50:51.157 ios_chrome_web_egtests[12336:107276] Attempting to type key h.\n[08:50:51:INFO] 2019-05-25 08:50:51.160 ios_chrome_web_egtests[12336:107276] Tapping on key: h.\n[08:50:51:INFO] 2019-05-25 08:50:51.217 ios_chrome_web_egtests[12336:107276] Attempting to type key t.\n[08:50:51:INFO] 2019-05-25 08:50:51.219 ios_chrome_web_egtests[12336:107276] Tapping on key: t.\n[08:50:51:INFO] 2019-05-25 08:50:51.276 ios_chrome_web_egtests[12336:107276] Attempting to type key t.\n[08:50:51:INFO] 2019-05-25 08:50:51.277 ios_chrome_web_egtests[12336:107276] Tapping on key: t.\n[08:50:51:INFO] 2019-05-25 08:50:51.332 ios_chrome_web_egtests[12336:107276] Attempting to type key p.\n[08:50:51:INFO] 2019-05-25 08:50:51.333 ios_chrome_web_egtests[12336:107276] Tapping on key: p.\n[08:50:51:INFO] 2019-05-25 08:50:51.390 ios_chrome_web_egtests[12336:107276] Attempting to type key :.\n[08:50:51:INFO] 2019-05-25 08:50:51.492 ios_chrome_web_egtests[12336:107276] Tapping on key: more, numbers.\n[08:50:51:INFO] 2019-05-25 08:50:51.545 ios_chrome_web_egtests[12336:107276] Tapping on key: :.\n[08:50:51:INFO] 2019-05-25 08:50:51.607 ios_chrome_web_egtests[12336:107276] Attempting to type key /.\n[08:50:51:INFO] 2019-05-25 08:50:51.608 ios_chrome_web_egtests[12336:107276] Tapping on key: /.\n[08:50:51:INFO] 2019-05-25 08:50:51.665 ios_chrome_web_egtests[12336:107276] Attempting to type key /.\n[08:50:51:INFO] 2019-05-25 08:50:51.666 ios_chrome_web_egtests[12336:107276] Tapping on key: /.\n[08:50:51:INFO] 2019-05-25 08:50:51.721 ios_chrome_web_egtests[12336:107276] Attempting to type key 1.\n[08:50:51:INFO] 2019-05-25 08:50:51.722 ios_chrome_web_egtests[12336:107276] Tapping on key: 1.\n[08:50:51:INFO] 2019-05-25 08:50:51.776 ios_chrome_web_egtests[12336:107276] Attempting to type key 2.\n[08:50:51:INFO] 2019-05-25 08:50:51.777 ios_chrome_web_egtests[12336:107276] Tapping on key: 2.\n[08:50:51:INFO] 2019-05-25 08:50:51.832 ios_chrome_web_egtests[12336:107276] Attempting to type key 7.\n[08:50:51:INFO] 2019-05-25 08:50:51.832 ios_chrome_web_egtests[12336:107276] Tapping on key: 7.\n[08:50:51:INFO] 2019-05-25 08:50:51.887 ios_chrome_web_egtests[12336:107276] Attempting to type key ..\n[08:50:51:INFO] 2019-05-25 08:50:51.889 ios_chrome_web_egtests[12336:107276] Tapping on key: ..\n[08:50:51:INFO] 2019-05-25 08:50:51.943 ios_chrome_web_egtests[12336:107276] Attempting to type key 0.\n[08:50:51:INFO] 2019-05-25 08:50:51.944 ios_chrome_web_egtests[12336:107276] Tapping on key: 0.\n[08:50:52:INFO] 2019-05-25 08:50:52.001 ios_chrome_web_egtests[12336:107276] Attempting to type key ..\n[08:50:52:INFO] 2019-05-25 08:50:52.002 ios_chrome_web_egtests[12336:107276] Tapping on key: ..\n[08:50:52:INFO] 2019-05-25 08:50:52.063 ios_chrome_web_egtests[12336:107276] Attempting to type key 0.\n[08:50:52:INFO] 2019-05-25 08:50:52.064 ios_chrome_web_egtests[12336:107276] Tapping on key: 0.\n[08:50:52:INFO] 2019-05-25 08:50:52.121 ios_chrome_web_egtests[12336:107276] Attempting to type key ..\n[08:50:52:INFO] 2019-05-25 08:50:52.123 ios_chrome_web_egtests[12336:107276] Tapping on key: ..\n[08:50:52:INFO] 2019-05-25 08:50:52.181 ios_chrome_web_egtests[12336:107276] Attempting to type key 1.\n[08:50:52:INFO] 2019-05-25 08:50:52.181 ios_chrome_web_egtests[12336:107276] Tapping on key: 1.\n[08:50:52:INFO] 2019-05-25 08:50:52.240 ios_chrome_web_egtests[12336:107276] Attempting to type key :.\n[08:50:52:INFO] 2019-05-25 08:50:52.241 ios_chrome_web_egtests[12336:107276] Tapping on key: :.\n[08:50:52:INFO] 2019-05-25 08:50:52.300 ios_chrome_web_egtests[12336:107276] Attempting to type key 5.\n[08:50:52:INFO] 2019-05-25 08:50:52.301 ios_chrome_web_egtests[12336:107276] Tapping on key: 5.\n[08:50:52:INFO] 2019-05-25 08:50:52.361 ios_chrome_web_egtests[12336:107276] Attempting to type key 0.\n[08:50:52:INFO] 2019-05-25 08:50:52.361 ios_chrome_web_egtests[12336:107276] Tapping on key: 0.\n[08:50:52:INFO] 2019-05-25 08:50:52.420 ios_chrome_web_egtests[12336:107276] Attempting to type key 3.\n[08:50:52:INFO] 2019-05-25 08:50:52.421 ios_chrome_web_egtests[12336:107276] Tapping on key: 3.\n[08:50:52:INFO] 2019-05-25 08:50:52.481 ios_chrome_web_egtests[12336:107276] Attempting to type key 9.\n[08:50:52:INFO] 2019-05-25 08:50:52.482 ios_chrome_web_egtests[12336:107276] Tapping on key: 9.\n[08:50:52:INFO] 2019-05-25 08:50:52.542 ios_chrome_web_egtests[12336:107276] Attempting to type key 3.\n[08:50:52:INFO] 2019-05-25 08:50:52.542 ios_chrome_web_egtests[12336:107276] Tapping on key: 3.\n[08:50:52:INFO] 2019-05-25 08:50:52.601 ios_chrome_web_egtests[12336:107276] Attempting to type key /.\n[08:50:52:INFO] 2019-05-25 08:50:52.602 ios_chrome_web_egtests[12336:107276] Tapping on key: /.\n[08:50:52:INFO] 2019-05-25 08:50:52.660 ios_chrome_web_egtests[12336:107276] Attempting to type key t.\n[08:50:52:INFO] 2019-05-25 08:50:52.965 ios_chrome_web_egtests[12336:107276] Tapping on key: more, letters.\n[08:50:53:INFO] 2019-05-25 08:50:53.019 ios_chrome_web_egtests[12336:107276] Tapping on key: t.\n[08:50:53:INFO] 2019-05-25 08:50:53.074 ios_chrome_web_egtests[12336:107276] Attempting to type key a.\n[08:50:53:INFO] 2019-05-25 08:50:53.075 ios_chrome_web_egtests[12336:107276] Tapping on key: a.\n[08:50:53:INFO] 2019-05-25 08:50:53.135 ios_chrome_web_egtests[12336:107276] Attempting to type key r.\n[08:50:53:INFO] 2019-05-25 08:50:53.136 ios_chrome_web_egtests[12336:107276] Tapping on key: r.\n[08:50:53:INFO] 2019-05-25 08:50:53.196 ios_chrome_web_egtests[12336:107276] Attempting to type key g.\n[08:50:53:INFO] 2019-05-25 08:50:53.197 ios_chrome_web_egtests[12336:107276] Tapping on key: g.\n[08:50:53:INFO] 2019-05-25 08:50:53.257 ios_chrome_web_egtests[12336:107276] Attempting to type key e.\n[08:50:53:INFO] 2019-05-25 08:50:53.257 ios_chrome_web_egtests[12336:107276] Tapping on key: e.\n[08:50:53:INFO] 2019-05-25 08:50:53.317 ios_chrome_web_egtests[12336:107276] Attempting to type key t.\n[08:50:53:INFO] 2019-05-25 08:50:53.318 ios_chrome_web_egtests[12336:107276] Tapping on key: t.\n[08:50:53:INFO] 2019-05-25 08:50:53.378 ios_chrome_web_egtests[12336:107276] Attempting to type key p.\n[08:50:53:INFO] 2019-05-25 08:50:53.379 ios_chrome_web_egtests[12336:107276] Tapping on key: p.\n[08:50:53:INFO] 2019-05-25 08:50:53.437 ios_chrome_web_egtests[12336:107276] Attempting to type key a.\n[08:50:53:INFO] 2019-05-25 08:50:53.438 ios_chrome_web_egtests[12336:107276] Tapping on key: a.\n[08:50:53:INFO] 2019-05-25 08:50:53.499 ios_chrome_web_egtests[12336:107276] Attempting to type key g.\n[08:50:53:INFO] 2019-05-25 08:50:53.499 ios_chrome_web_egtests[12336:107276] Tapping on key: g.\n[08:50:53:INFO] 2019-05-25 08:50:53.559 ios_chrome_web_egtests[12336:107276] Attempting to type key e.\n[08:50:53:INFO] 2019-05-25 08:50:53.559 ios_chrome_web_egtests[12336:107276] Tapping on key: e.\n[08:50:53:INFO] 2019-05-25 08:50:53.620 ios_chrome_web_egtests[12336:107276] Attempting to type key /.\n[08:50:53:INFO] 2019-05-25 08:50:53.723 ios_chrome_web_egtests[12336:107276] Tapping on key: more, numbers.\n[08:50:53:INFO] 2019-05-25 08:50:53.777 ios_chrome_web_egtests[12336:107276] Tapping on key: /.\n[08:50:53:INFO] 2019-05-25 08:50:53.841 ios_chrome_web_egtests[12336:107276] Attempting to type key '.\n[08:50:53:INFO] 2019-05-25 08:50:53.843 ios_chrome_web_egtests[12336:107276] Tapping on key: '.\n[08:50:58:INFO] Test Case '-[BrowsingTestCase testBrowsingUserJavaScriptNavigation]' passed (14.882 seconds).\n[08:50:58:INFO] Test Case '-[BrowsingTestCase testBrowsingUserJavaScriptWithoutNavigation]' started.\n[08:51:04:INFO] 2019-05-25 08:51:04.043 ios_chrome_web_egtests[12336:107276] Attempting to type key j.\n[08:51:04:INFO] 2019-05-25 08:51:04.045 ios_chrome_web_egtests[12336:107276] Tapping on key: j.\n[08:51:04:INFO] 2019-05-25 08:51:04.104 ios_chrome_web_egtests[12336:107276] Attempting to type key a.\n[08:51:04:INFO] 2019-05-25 08:51:04.105 ios_chrome_web_egtests[12336:107276] Tapping on key: a.\n[08:51:04:INFO] 2019-05-25 08:51:04.160 ios_chrome_web_egtests[12336:107276] Attempting to type key v.\n[08:51:04:INFO] 2019-05-25 08:51:04.161 ios_chrome_web_egtests[12336:107276] Tapping on key: v.\n[08:51:04:INFO] 2019-05-25 08:51:04.214 ios_chrome_web_egtests[12336:107276] Attempting to type key a.\n[08:51:04:INFO] 2019-05-25 08:51:04.214 ios_chrome_web_egtests[12336:107276] Tapping on key: a.\n[08:51:04:INFO] 2019-05-25 08:51:04.271 ios_chrome_web_egtests[12336:107276] Attempting to type key s.\n[08:51:04:INFO] 2019-05-25 08:51:04.272 ios_chrome_web_egtests[12336:107276] Tapping on key: s.\n[08:51:04:INFO] 2019-05-25 08:51:04.332 ios_chrome_web_egtests[12336:107276] Attempting to type key c.\n[08:51:04:INFO] 2019-05-25 08:51:04.333 ios_chrome_web_egtests[12336:107276] Tapping on key: c.\n[08:51:04:INFO] 2019-05-25 08:51:04.389 ios_chrome_web_egtests[12336:107276] Attempting to type key r.\n[08:51:04:INFO] 2019-05-25 08:51:04.390 ios_chrome_web_egtests[12336:107276] Tapping on key: r.\n[08:51:04:INFO] 2019-05-25 08:51:04.447 ios_chrome_web_egtests[12336:107276] Attempting to type key i.\n[08:51:04:INFO] 2019-05-25 08:51:04.448 ios_chrome_web_egtests[12336:107276] Tapping on key: i.\n[08:51:04:INFO] 2019-05-25 08:51:04.502 ios_chrome_web_egtests[12336:107276] Attempting to type key p.\n[08:51:04:INFO] 2019-05-25 08:51:04.503 ios_chrome_web_egtests[12336:107276] Tapping on key: p.\n[08:51:04:INFO] 2019-05-25 08:51:04.556 ios_chrome_web_egtests[12336:107276] Attempting to type key t.\n[08:51:04:INFO] 2019-05-25 08:51:04.557 ios_chrome_web_egtests[12336:107276] Tapping on key: t.\n[08:51:04:INFO] 2019-05-25 08:51:04.610 ios_chrome_web_egtests[12336:107276] Attempting to type key :.\n[08:51:04:INFO] 2019-05-25 08:51:04.714 ios_chrome_web_egtests[12336:107276] Tapping on key: more, numbers.\n[08:51:04:INFO] 2019-05-25 08:51:04.768 ios_chrome_web_egtests[12336:107276] Tapping on key: :.\n[08:51:04:INFO] 2019-05-25 08:51:04.829 ios_chrome_web_egtests[12336:107276] Attempting to type key d.\n[08:51:05:INFO] 2019-05-25 08:51:05.136 ios_chrome_web_egtests[12336:107276] Tapping on key: more, letters.\n[08:51:05:INFO] 2019-05-25 08:51:05.190 ios_chrome_web_egtests[12336:107276] Tapping on key: d.\n[08:51:05:INFO] 2019-05-25 08:51:05.242 ios_chrome_web_egtests[12336:107276] Attempting to type key o.\n[08:51:05:INFO] 2019-05-25 08:51:05.243 ios_chrome_web_egtests[12336:107276] Tapping on key: o.\n[08:51:05:INFO] 2019-05-25 08:51:05.295 ios_chrome_web_egtests[12336:107276] Attempting to type key c.\n[08:51:05:INFO] 2019-05-25 08:51:05.297 ios_chrome_web_egtests[12336:107276] Tapping on key: c.\n[08:51:05:INFO] 2019-05-25 08:51:05.350 ios_chrome_web_egtests[12336:107276] Attempting to type key u.\n[08:51:05:INFO] 2019-05-25 08:51:05.350 ios_chrome_web_egtests[12336:107276] Tapping on key: u.\n[08:51:05:INFO] 2019-05-25 08:51:05.405 ios_chrome_web_egtests[12336:107276] Attempting to type key m.\n[08:51:05:INFO] 2019-05-25 08:51:05.406 ios_chrome_web_egtests[12336:107276] Tapping on key: m.\n[08:51:05:INFO] 2019-05-25 08:51:05.459 ios_chrome_web_egtests[12336:107276] Attempting to type key e.\n[08:51:05:INFO] 2019-05-25 08:51:05.460 ios_chrome_web_egtests[12336:107276] Tapping on key: e.\n[08:51:05:INFO] 2019-05-25 08:51:05.513 ios_chrome_web_egtests[12336:107276] Attempting to type key n.\n[08:51:05:INFO] 2019-05-25 08:51:05.514 ios_chrome_web_egtests[12336:107276] Tapping on key: n.\n[08:51:05:INFO] 2019-05-25 08:51:05.566 ios_chrome_web_egtests[12336:107276] Attempting to type key t.\n[08:51:05:INFO] 2019-05-25 08:51:05.566 ios_chrome_web_egtests[12336:107276] Tapping on key: t.\n[08:51:05:INFO] 2019-05-25 08:51:05.618 ios_chrome_web_egtests[12336:107276] Attempting to type key ..\n[08:51:05:INFO] 2019-05-25 08:51:05.619 ios_chrome_web_egtests[12336:107276] Tapping on key: ..\n[08:51:05:INFO] 2019-05-25 08:51:05.685 ios_chrome_web_egtests[12336:107276] Attempting to type key w.\n[08:51:05:INFO] 2019-05-25 08:51:05.685 ios_chrome_web_egtests[12336:107276] Tapping on key: w.\n[08:51:05:INFO] 2019-05-25 08:51:05.741 ios_chrome_web_egtests[12336:107276] Attempting to type key r.\n[08:51:05:INFO] 2019-05-25 08:51:05.741 ios_chrome_web_egtests[12336:107276] Tapping on key: r.\n[08:51:05:INFO] 2019-05-25 08:51:05.794 ios_chrome_web_egtests[12336:107276] Attempting to type key i.\n[08:51:05:INFO] 2019-05-25 08:51:05.795 ios_chrome_web_egtests[12336:107276] Tapping on key: i.\n[08:51:05:INFO] 2019-05-25 08:51:05.848 ios_chrome_web_egtests[12336:107276] Attempting to type key t.\n[08:51:05:INFO] 2019-05-25 08:51:05.849 ios_chrome_web_egtests[12336:107276] Tapping on key: t.\n[08:51:05:INFO] 2019-05-25 08:51:05.903 ios_chrome_web_egtests[12336:107276] Attempting to type key e.\n[08:51:05:INFO] 2019-05-25 08:51:05.903 ios_chrome_web_egtests[12336:107276] Tapping on key: e.\n[08:51:05:INFO] 2019-05-25 08:51:05.955 ios_chrome_web_egtests[12336:107276] Attempting to type key (.\n[08:51:06:INFO] 2019-05-25 08:51:06.058 ios_chrome_web_egtests[12336:107276] Tapping on key: more, numbers.\n[08:51:06:INFO] 2019-05-25 08:51:06.112 ios_chrome_web_egtests[12336:107276] Tapping on key: (.\n[08:51:06:INFO] 2019-05-25 08:51:06.167 ios_chrome_web_egtests[12336:107276] Attempting to type key '.\n[08:51:06:INFO] 2019-05-25 08:51:06.170 ios_chrome_web_egtests[12336:107276] Tapping on key: '.\n[08:51:06:INFO] 2019-05-25 08:51:06.238 ios_chrome_web_egtests[12336:107276] Attempting to type key f.\n[08:51:06:INFO] 2019-05-25 08:51:06.240 ios_chrome_web_egtests[12336:107276] Tapping on key: f.\n[08:51:06:INFO] 2019-05-25 08:51:06.295 ios_chrome_web_egtests[12336:107276] Attempting to type key o.\n[08:51:06:INFO] 2019-05-25 08:51:06.296 ios_chrome_web_egtests[12336:107276] Tapping on key: o.\n[08:51:06:INFO] 2019-05-25 08:51:06.348 ios_chrome_web_egtests[12336:107276] Attempting to type key o.\n[08:51:06:INFO] 2019-05-25 08:51:06.349 ios_chrome_web_egtests[12336:107276] Tapping on key: o.\n[08:51:06:INFO] 2019-05-25 08:51:06.403 ios_chrome_web_egtests[12336:107276] Attempting to type key '.\n[08:51:06:INFO] 2019-05-25 08:51:06.506 ios_chrome_web_egtests[12336:107276] Tapping on key: more, numbers.\n[08:51:06:INFO] 2019-05-25 08:51:06.560 ios_chrome_web_egtests[12336:107276] Tapping on key: '.\n[08:51:06:INFO] 2019-05-25 08:51:06.629 ios_chrome_web_egtests[12336:107276] Attempting to type key ).\n[08:51:06:INFO] 2019-05-25 08:51:06.732 ios_chrome_web_egtests[12336:107276] Tapping on key: more, numbers.\n[08:51:06:INFO] 2019-05-25 08:51:06.785 ios_chrome_web_egtests[12336:107276] Tapping on key: ).\n[08:51:06:INFO] 2019-05-25 08:51:06.845 ios_chrome_web_egtests[12336:107276] Attempting to type key\n[08:51:06:INFO] .\n[08:51:06:INFO] 2019-05-25 08:51:06.848 ios_chrome_web_egtests[12336:107276] Tapping on key: Go.\n[08:51:11:INFO] Test Case '-[BrowsingTestCase testBrowsingUserJavaScriptWithoutNavigation]' passed (12.830 seconds).\n[08:51:11:INFO] Test Case '-[BrowsingTestCase testBrowsingWindowDataLinkScriptRedirect]' started.\n[08:51:17:INFO] Test Case '-[BrowsingTestCase testBrowsingWindowDataLinkScriptRedirect]' passed (6.187 seconds).\n[08:51:17:INFO] Test Case '-[BrowsingTestCase testPDFLoadTitle]' started.\n[08:51:19:INFO] 2019-05-25 08:51:19.684 ios_chrome_web_egtests[12336:107276] -- Earl Grey Test Skipped -- Tab Title not displayed on handset.\n[08:51:21:INFO] Test Case '-[BrowsingTestCase testPDFLoadTitle]' passed (3.698 seconds).\n[08:51:21:INFO] Test Case '-[BrowsingTestCase testReload]' started.\n[08:51:29:INFO] Test Case '-[BrowsingTestCase testReload]' passed (8.309 seconds).\n[08:51:29:INFO] Test Case '-[BrowsingTestCase testTapLinkWithWebUIURL]' started.\n[08:51:34:INFO] Test Case '-[BrowsingTestCase testTapLinkWithWebUIURL]' passed (5.017 seconds).\n[08:51:34:INFO] Test Suite 'BrowsingTestCase' passed at 2019-05-25 08:51:34.889.\n[08:51:34:INFO] \t Executed 11 tests, with 0 failures (0 unexpected) in 77.513 (77.526) seconds\n[08:51:34:INFO] Test Suite 'CacheTestCase' started at 2019-05-25 08:51:34.890\n[08:51:34:INFO] [0525/085134.891411:WARNING:loopback_server.cc(835)] Loopback sync persistent state file does not exist.\n[08:51:34:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnNavigateBackAndPageReload]' started.\n[08:51:36:INFO] 2019-05-25 08:51:36.727 ios_chrome_web_egtests[12336:107276] -- Earl Grey Test Disabled -- Disabled on iOS 10.3.1 and afterwards.\n[08:51:38:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnNavigateBackAndPageReload]' passed (3.712 seconds).\n[08:51:38:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnOpenNewTab]' started.\n[08:51:40:INFO] [0525/085140.704819:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:51:45:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnOpenNewTab]' passed (7.164 seconds).\n[08:51:45:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnSelectOmniboxSuggestion]' started.\n[08:51:50:INFO] 2019-05-25 08:51:50.122 ios_chrome_web_egtests[12336:107276] Attempting to type key c.\n[08:51:50:INFO] 2019-05-25 08:51:50.123 ios_chrome_web_egtests[12336:107276] Tapping on key: c.\n[08:51:50:INFO] 2019-05-25 08:51:50.197 ios_chrome_web_egtests[12336:107276] Attempting to type key a.\n[08:51:50:INFO] 2019-05-25 08:51:50.198 ios_chrome_web_egtests[12336:107276] Tapping on key: a.\n[08:51:50:INFO] 2019-05-25 08:51:50.284 ios_chrome_web_egtests[12336:107276] Attempting to type key c.\n[08:51:50:INFO] 2019-05-25 08:51:50.286 ios_chrome_web_egtests[12336:107276] Tapping on key: c.\n[08:51:50:INFO] 2019-05-25 08:51:50.362 ios_chrome_web_egtests[12336:107276] Attempting to type key h.\n[08:51:50:INFO] 2019-05-25 08:51:50.363 ios_chrome_web_egtests[12336:107276] Tapping on key: h.\n[08:51:50:INFO] 2019-05-25 08:51:50.437 ios_chrome_web_egtests[12336:107276] Attempting to type key e.\n[08:51:50:INFO] 2019-05-25 08:51:50.438 ios_chrome_web_egtests[12336:107276] Tapping on key: e.\n[08:51:50:INFO] 2019-05-25 08:51:50.509 ios_chrome_web_egtests[12336:107276] Attempting to type key t.\n[08:51:50:INFO] 2019-05-25 08:51:50.510 ios_chrome_web_egtests[12336:107276] Tapping on key: t.\n[08:51:50:INFO] 2019-05-25 08:51:50.586 ios_chrome_web_egtests[12336:107276] Attempting to type key e.\n[08:51:50:INFO] 2019-05-25 08:51:50.586 ios_chrome_web_egtests[12336:107276] Tapping on key: e.\n[08:51:50:INFO] 2019-05-25 08:51:50.660 ios_chrome_web_egtests[12336:107276] Attempting to type key s.\n[08:51:50:INFO] 2019-05-25 08:51:50.661 ios_chrome_web_egtests[12336:107276] Tapping on key: s.\n[08:51:50:INFO] 2019-05-25 08:51:50.732 ios_chrome_web_egtests[12336:107276] Attempting to type key t.\n[08:51:50:INFO] 2019-05-25 08:51:50.733 ios_chrome_web_egtests[12336:107276] Tapping on key: t.\n[08:51:50:INFO] 2019-05-25 08:51:50.805 ios_chrome_web_egtests[12336:107276] Attempting to type key f.\n[08:51:50:INFO] 2019-05-25 08:51:50.806 ios_chrome_web_egtests[12336:107276] Tapping on key: f.\n[08:51:50:INFO] 2019-05-25 08:51:50.877 ios_chrome_web_egtests[12336:107276] Attempting to type key i.\n[08:51:50:INFO] 2019-05-25 08:51:50.878 ios_chrome_web_egtests[12336:107276] Tapping on key: i.\n[08:51:50:INFO] 2019-05-25 08:51:50.949 ios_chrome_web_egtests[12336:107276] Attempting to type key r.\n[08:51:50:INFO] 2019-05-25 08:51:50.951 ios_chrome_web_egtests[12336:107276] Tapping on key: r.\n[08:51:51:INFO] 2019-05-25 08:51:51.023 ios_chrome_web_egtests[12336:107276] Attempting to type key s.\n[08:51:51:INFO] 2019-05-25 08:51:51.024 ios_chrome_web_egtests[12336:107276] Tapping on key: s.\n[08:51:51:INFO] 2019-05-25 08:51:51.095 ios_chrome_web_egtests[12336:107276] Attempting to type key t.\n[08:51:51:INFO] 2019-05-25 08:51:51.096 ios_chrome_web_egtests[12336:107276] Tapping on key: t.\n[08:51:51:INFO] 2019-05-25 08:51:51.167 ios_chrome_web_egtests[12336:107276] Attempting to type key p.\n[08:51:51:INFO] 2019-05-25 08:51:51.168 ios_chrome_web_egtests[12336:107276] Tapping on key: p.\n[08:51:51:INFO] 2019-05-25 08:51:51.238 ios_chrome_web_egtests[12336:107276] Attempting to type key a.\n[08:51:51:INFO] 2019-05-25 08:51:51.239 ios_chrome_web_egtests[12336:107276] Tapping on key: a.\n[08:51:51:INFO] 2019-05-25 08:51:51.312 ios_chrome_web_egtests[12336:107276] Attempting to type key g.\n[08:51:51:INFO] 2019-05-25 08:51:51.314 ios_chrome_web_egtests[12336:107276] Tapping on key: g.\n[08:51:51:INFO] 2019-05-25 08:51:51.384 ios_chrome_web_egtests[12336:107276] Attempting to type key e.\n[08:51:51:INFO] 2019-05-25 08:51:51.385 ios_chrome_web_egtests[12336:107276] Tapping on key: e.\n[08:51:55:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnSelectOmniboxSuggestion]' passed (9.489 seconds).\n[08:51:55:INFO] Test Suite 'CacheTestCase' passed at 2019-05-25 08:51:55.260.\n[08:51:55:INFO] \t Executed 3 tests, with 0 failures (0 unexpected) in 20.365 (20.370) seconds\n[08:51:55:INFO] Test Suite 'ChildWindowOpenByDOMTestCase' started at 2019-05-25 08:51:55.260\n[08:51:55:INFO] [0525/085155.261813:WARNING:loopback_server.cc(835)] Loopback sync persistent state file does not exist.\n[08:51:55:INFO] Test Case '-[ChildWindowOpenByDOMTestCase test2ChildWindowsWithName]' started.\n[08:51:57:INFO] [0525/085157.424698:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:52:01:INFO] Test Case '-[ChildWindowOpenByDOMTestCase test2ChildWindowsWithName]' passed (6.606 seconds).\n[08:52:01:INFO] Test Case '-[ChildWindowOpenByDOMTestCase test2ChildWindowsWithoutName]' started.\n[08:52:09:INFO] Test Case '-[ChildWindowOpenByDOMTestCase test2ChildWindowsWithoutName]' passed (7.598 seconds).\n[08:52:09:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testChildWindowsWithAndWithoutName]' started.\n[08:52:17:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testChildWindowsWithAndWithoutName]' passed (7.619 seconds).\n[08:52:17:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testWindowClosedWithName]' started.\n[08:52:24:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testWindowClosedWithName]' passed (7.316 seconds).\n[08:52:24:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testWindowClosedWithoutName]' started.\n[08:52:33:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testWindowClosedWithoutName]' passed (8.903 seconds).\n[08:52:33:INFO] Test Suite 'ChildWindowOpenByDOMTestCase' passed at 2019-05-25 08:52:33.348.\n[08:52:33:INFO] \t Executed 5 tests, with 0 failures (0 unexpected) in 38.042 (38.088) seconds\n[08:52:33:INFO] Test Suite 'ErrorPageTestCase' started at 2019-05-25 08:52:33.349\n[08:52:33:INFO] [0525/085233.357607:WARNING:loopback_server.cc(835)] Loopback sync persistent state file does not exist.\n[08:52:33:INFO] Test Case '-[ErrorPageTestCase testReloadErrorPage]' started.\n[08:52:35:INFO] [0525/085235.579759:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:52:39:INFO] Test Case '-[ErrorPageTestCase testReloadErrorPage]' passed (6.296 seconds).\n[08:52:39:INFO] Test Case '-[ErrorPageTestCase testReloadPageAfterServerIsDown]' started.\n[08:52:41:INFO] [0525/085241.751957:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:52:45:INFO] Test Case '-[ErrorPageTestCase testReloadPageAfterServerIsDown]' passed (6.115 seconds).\n[08:52:45:INFO] Test Suite 'ErrorPageTestCase' passed at 2019-05-25 08:52:45.771.\n[08:52:45:INFO] \t Executed 2 tests, with 0 failures (0 unexpected) in 12.411 (12.422) seconds\n[08:52:45:INFO] Test Suite 'FormsTestCase' started at 2019-05-25 08:52:45.772\n[08:52:45:INFO] [0525/085245.773474:WARNING:loopback_server.cc(835)] Loopback sync persistent state file does not exist.\n[08:52:45:INFO] Test Case '-[FormsTestCase testGoBackButtonAfterFormSubmission]' started.\n[08:52:47:INFO] [0525/085247.899663:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:52:52:INFO] Test Case '-[FormsTestCase testGoBackButtonAfterFormSubmission]' passed (7.159 seconds).\n[08:52:52:INFO] Test Case '-[FormsTestCase testPostFormEntryWithKeyboard]' started.\n[08:52:58:INFO] [0525/085258.458624:WARNING:web_state_impl.mm(668)] Script execution has failed: A JavaScript exception occurred\n[08:53:02:INFO] Test Case '-[FormsTestCase testPostFormEntryWithKeyboard]' passed (9.530 seconds).\n[08:53:02:INFO] Test Case '-[FormsTestCase testPostFormToSamePage]' started.\n[08:53:11:INFO] Test Case '-[FormsTestCase testPostFormToSamePage]' passed (9.227 seconds).\n[08:53:11:INFO] Test Case '-[FormsTestCase testRepostFormAfterIndexNavigation]' started.\n[08:53:24:INFO] Test Case '-[FormsTestCase testRepostFormAfterIndexNavigation]' passed (12.760 seconds).\n[08:53:24:INFO] Test Case '-[FormsTestCase testRepostFormAfterReload]' started.\n[08:53:33:INFO] Test Case '-[FormsTestCase testRepostFormAfterReload]' passed (9.147 seconds).\n[08:53:33:INFO] Test Case '-[FormsTestCase testRepostFormAfterTappingBack]' started.\n[08:53:43:INFO] Test Case '-[FormsTestCase testRepostFormAfterTappingBack]' passed (10.230 seconds).\n[08:53:43:INFO] Test Case '-[FormsTestCase testRepostFormAfterTappingBackAndForward]' started.\n[08:53:54:INFO] Test Case '-[FormsTestCase testRepostFormAfterTappingBackAndForward]' passed (10.211 seconds).\n[08:53:54:INFO] Test Case '-[FormsTestCase testRepostFormCancelling]' started.\n[08:54:02:INFO] Test Case '-[FormsTestCase testRepostFormCancelling]' passed (8.819 seconds).\n[08:54:02:INFO] Test Case '-[FormsTestCase testRepostFormCancellingAfterRedirect]' started.\n[08:54:09:INFO] Test Case '-[FormsTestCase testRepostFormCancellingAfterRedirect]' passed (7.114 seconds).\n[08:54:09:INFO] Test Case '-[FormsTestCase testRepostFormDismissedByNewNavigation]' started.\n[08:54:18:INFO] Test Case '-[FormsTestCase testRepostFormDismissedByNewNavigation]' passed (8.053 seconds).\n[08:54:18:INFO] Test Suite 'FormsTestCase' passed at 2019-05-25 08:54:18.031.\n[08:54:18:INFO] \t Executed 10 tests, with 0 failures (0 unexpected) in 92.250 (92.259) seconds\n[08:54:18:INFO] Test Suite 'HTTPAuthTestCase' started at 2019-05-25 08:54:18.032\n[08:54:18:INFO] [0525/085418.033483:WARNING:loopback_server.cc(835)] Loopback sync persistent state file does not exist.\n[08:54:18:INFO] Test Case '-[HTTPAuthTestCase testCancellingBasicAuth]' started.\n[08:54:23:INFO] Test Case '-[HTTPAuthTestCase testCancellingBasicAuth]' passed (5.688 seconds).\n[08:54:23:INFO] Test Case '-[HTTPAuthTestCase testSuccessfullBasicAuth]' started.\n[08:54:26:INFO] 2019-05-25 08:54:26.563 ios_chrome_web_egtests[12336:107276] Attempting to type key g.\n[08:54:26:INFO] 2019-05-25 08:54:26.563 ios_chrome_web_egtests[12336:107276] Tapping on key: g.\n[08:54:26:INFO] 2019-05-25 08:54:26.616 ios_chrome_web_egtests[12336:107276] Attempting to type key o.\n[08:54:26:INFO] 2019-05-25 08:54:26.617 ios_chrome_web_egtests[12336:107276] Tapping on key: o.\n[08:54:26:INFO] 2019-05-25 08:54:26.667 ios_chrome_web_egtests[12336:107276] Attempting to type key o.\n[08:54:26:INFO] 2019-05-25 08:54:26.668 ios_chrome_web_egtests[12336:107276] Tapping on key: o.\n[08:54:26:INFO] 2019-05-25 08:54:26.721 ios_chrome_web_egtests[12336:107276] Attempting to type key d.\n[08:54:26:INFO] 2019-05-25 08:54:26.721 ios_chrome_web_egtests[12336:107276] Tapping on key: d.\n[08:54:26:INFO] 2019-05-25 08:54:26.773 ios_chrome_web_egtests[12336:107276] Attempting to type key u.\n[08:54:26:INFO] 2019-05-25 08:54:26.773 ios_chrome_web_egtests[12336:107276] Tapping on key: u.\n[08:54:26:INFO] 2019-05-25 08:54:26.826 ios_chrome_web_egtests[12336:107276] Attempting to type key s.\n[08:54:26:INFO] 2019-05-25 08:54:26.827 ios_chrome_web_egtests[12336:107276] Tapping on key: s.\n[08:54:26:INFO] 2019-05-25 08:54:26.878 ios_chrome_web_egtests[12336:107276] Attempting to type key e.\n[08:54:26:INFO] 2019-05-25 08:54:26.878 ios_chrome_web_egtests[12336:107276] Tapping on key: e.\n[08:54:26:INFO] 2019-05-25 08:54:26.931 ios_chrome_web_egtests[12336:107276] Attempting to type key r.\n[08:54:26:INFO] 2019-05-25 08:54:26.931 ios_chrome_web_egtests[12336:107276] Tapping on key: r.\n[08:54:27:INFO] 2019-05-25 08:54:27.779 ios_chrome_web_egtests[12336:107276] Attempting to type key g.\n[08:54:27:INFO] 2019-05-25 08:54:27.780 ios_chrome_web_egtests[12336:107276] Tapping on key: g.\n[08:54:27:INFO] 2019-05-25 08:54:27.833 ios_chrome_web_egtests[12336:107276] Attempting to type key o.\n[08:54:27:INFO] 2019-05-25 08:54:27.834 ios_chrome_web_egtests[12336:107276] Tapping on key: o.\n[08:54:27:INFO] 2019-05-25 08:54:27.886 ios_chrome_web_egtests[12336:107276] Attempting to type key o.\n[08:54:27:INFO] 2019-05-25 08:54:27.887 ios_chrome_web_egtests[12336:107276] Tapping on key: o.\n[08:54:27:INFO] 2019-05-25 08:54:27.940 ios_chrome_web_egtests[12336:107276] Attempting to type key d.\n[08:54:27:INFO] 2019-05-25 08:54:27.941 ios_chrome_web_egtests[12336:107276] Tapping on key: d.\n[08:54:27:INFO] 2019-05-25 08:54:27.992 ios_chrome_web_egtests[12336:107276] Attempting to type key p.\n[08:54:27:INFO] 2019-05-25 08:54:27.993 ios_chrome_web_egtests[12336:107276] Tapping on key: p.\n[08:54:28:INFO] 2019-05-25 08:54:28.044 ios_chrome_web_egtests[12336:107276] Attempting to type key a.\n[08:54:28:INFO] 2019-05-25 08:54:28.044 ios_chrome_web_egtests[12336:107276] Tapping on key: a.\n[08:54:28:INFO] 2019-05-25 08:54:28.095 ios_chrome_web_egtests[12336:107276] Attempting to type key s.\n[08:54:28:INFO] 2019-05-25 08:54:28.096 ios_chrome_web_egtests[12336:107276] Tapping on key: s.\n[08:54:28:INFO] 2019-05-25 08:54:28.148 ios_chrome_web_egtests[12336:107276] Attempting to type key s.\n[08:54:28:INFO] 2019-05-25 08:54:28.148 ios_chrome_web_egtests[12336:107276] Tapping on key: s.\n[08:54:29:INFO] [0525/085429.637768:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:54:32:INFO] Test Case '-[HTTPAuthTestCase testSuccessfullBasicAuth]' passed (8.770 seconds).\n[08:54:32:INFO] Test Case '-[HTTPAuthTestCase testUnsuccessfullBasicAuth]' started.\n[08:54:35:INFO] 2019-05-25 08:54:35.387 ios_chrome_web_egtests[12336:107276] Attempting to type key g.\n[08:54:35:INFO] 2019-05-25 08:54:35.387 ios_chrome_web_egtests[12336:107276] Tapping on key: g.\n[08:54:35:INFO] 2019-05-25 08:54:35.440 ios_chrome_web_egtests[12336:107276] Attempting to type key o.\n[08:54:35:INFO] 2019-05-25 08:54:35.441 ios_chrome_web_egtests[12336:107276] Tapping on key: o.\n[08:54:35:INFO] 2019-05-25 08:54:35.492 ios_chrome_web_egtests[12336:107276] Attempting to type key o.\n[08:54:35:INFO] 2019-05-25 08:54:35.493 ios_chrome_web_egtests[12336:107276] Tapping on key: o.\n[08:54:35:INFO] 2019-05-25 08:54:35.546 ios_chrome_web_egtests[12336:107276] Attempting to type key d.\n[08:54:35:INFO] 2019-05-25 08:54:35.546 ios_chrome_web_egtests[12336:107276] Tapping on key: d.\n[08:54:35:INFO] 2019-05-25 08:54:35.598 ios_chrome_web_egtests[12336:107276] Attempting to type key u.\n[08:54:35:INFO] 2019-05-25 08:54:35.598 ios_chrome_web_egtests[12336:107276] Tapping on key: u.\n[08:54:35:INFO] 2019-05-25 08:54:35.651 ios_chrome_web_egtests[12336:107276] Attempting to type key s.\n[08:54:35:INFO] 2019-05-25 08:54:35.652 ios_chrome_web_egtests[12336:107276] Tapping on key: s.\n[08:54:35:INFO] 2019-05-25 08:54:35.704 ios_chrome_web_egtests[12336:107276] Attempting to type key e.\n[08:54:35:INFO] 2019-05-25 08:54:35.704 ios_chrome_web_egtests[12336:107276] Tapping on key: e.\n[08:54:35:INFO] 2019-05-25 08:54:35.757 ios_chrome_web_egtests[12336:107276] Attempting to type key r.\n[08:54:35:INFO] 2019-05-25 08:54:35.757 ios_chrome_web_egtests[12336:107276] Tapping on key: r.\n[08:54:36:INFO] 2019-05-25 08:54:36.648 ios_chrome_web_egtests[12336:107276] Attempting to type key g.\n[08:54:36:INFO] 2019-05-25 08:54:36.649 ios_chrome_web_egtests[12336:107276] Tapping on key: g.\n[08:54:36:INFO] 2019-05-25 08:54:36.701 ios_chrome_web_egtests[12336:107276] Attempting to type key o.\n[08:54:36:INFO] 2019-05-25 08:54:36.702 ios_chrome_web_egtests[12336:107276] Tapping on key: o.\n[08:54:36:INFO] 2019-05-25 08:54:36.754 ios_chrome_web_egtests[12336:107276] Attempting to type key o.\n[08:54:36:INFO] 2019-05-25 08:54:36.755 ios_chrome_web_egtests[12336:107276] Tapping on key: o.\n[08:54:36:INFO] 2019-05-25 08:54:36.808 ios_chrome_web_egtests[12336:107276] Attempting to type key d.\n[08:54:36:INFO] 2019-05-25 08:54:36.809 ios_chrome_web_egtests[12336:107276] Tapping on key: d.\n[08:54:36:INFO] 2019-05-25 08:54:36.861 ios_chrome_web_egtests[12336:107276] Attempting to type key p.\n[08:54:36:INFO] 2019-05-25 08:54:36.861 ios_chrome_web_egtests[12336:107276] Tapping on key: p.\n[08:54:36:INFO] 2019-05-25 08:54:36.914 ios_chrome_web_egtests[12336:107276] Attempting to type key a.\n[08:54:36:INFO] 2019-05-25 08:54:36.915 ios_chrome_web_egtests[12336:107276] Tapping on key: a.\n[08:54:36:INFO] 2019-05-25 08:54:36.966 ios_chrome_web_egtests[12336:107276] Attempting to type key s.\n[08:54:36:INFO] 2019-05-25 08:54:36.966 ios_chrome_web_egtests[12336:107276] Tapping on key: s.\n[08:54:37:INFO] 2019-05-25 08:54:37.017 ios_chrome_web_egtests[12336:107276] Attempting to type key s.\n[08:54:37:INFO] 2019-05-25 08:54:37.018 ios_chrome_web_egtests[12336:107276] Tapping on key: s.\n[08:54:42:INFO] Test Case '-[HTTPAuthTestCase testUnsuccessfullBasicAuth]' passed (9.812 seconds).\n[08:54:42:INFO] Test Suite 'HTTPAuthTestCase' passed at 2019-05-25 08:54:42.307.\n[08:54:42:INFO] \t Executed 3 tests, with 0 failures (0 unexpected) in 24.270 (24.275) seconds\n[08:54:42:INFO] Test Suite 'JSPrintTestCase' started at 2019-05-25 08:54:42.308\n[08:54:42:INFO] [0525/085442.309157:WARNING:loopback_server.cc(835)] Loopback sync persistent state file does not exist.\n[08:54:42:INFO] Test Case '-[JSPrintTestCase testWebPrintButton]' started.\n[08:54:44:INFO] [0525/085444.419925:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:54:45:INFO] 2019-05-25 08:54:45.961 ios_chrome_web_egtests[12336:107276] Unbalanced calls to begin/end appearance transitions for <UIViewController: 0x7f8f1073b2f0>.\n[08:54:48:INFO] 2019-05-25 08:54:48.369 ios_chrome_web_egtests[12336:107276] Warning: Attempt to dismiss from view controller <UIViewController: 0x7f8f1073b2f0> while a presentation or dismiss is in progress!\n[08:54:51:INFO] Test Case '-[JSPrintTestCase testWebPrintButton]' passed (8.741 seconds).\n[08:54:51:INFO] Test Suite 'JSPrintTestCase' passed at 2019-05-25 08:54:51.057.\n[08:54:51:INFO] \t Executed 1 test, with 0 failures (0 unexpected) in 8.741 (8.749) seconds\n[08:54:51:INFO] Test Suite 'NavigationTestCase' started at 2019-05-25 08:54:51.058\n[08:54:51:INFO] [0525/085451.058981:WARNING:loopback_server.cc(835)] Loopback sync persistent state file does not exist.\n[08:54:51:INFO] Test Case '-[NavigationTestCase test301Redirect]' started.\n[08:54:53:INFO] [0525/085453.163203:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:55:01:INFO] Test Case '-[NavigationTestCase test301Redirect]' passed (10.906 seconds).\n[08:55:01:INFO] Test Case '-[NavigationTestCase testHistoryBackAndForwardAroundNTP]' started.\n[08:55:04:INFO] [0525/085504.073916:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:55:06:INFO] [0525/085506.814184:WARNING:web_state_impl.mm(668)] Script execution has failed: A JavaScript exception occurred\n[08:55:07:INFO] [0525/085507.459118:WARNING:web_state_impl.mm(668)] Script execution has failed: A JavaScript exception occurred\n[08:55:10:INFO] Test Case '-[NavigationTestCase testHistoryBackAndForwardAroundNTP]' passed (8.408 seconds).\n[08:55:10:INFO] Test Case '-[NavigationTestCase testHistoryBackNavigation]' started.\n[08:55:12:INFO] [0525/085512.475675:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:55:18:INFO] Test Case '-[NavigationTestCase testHistoryBackNavigation]' passed (8.382 seconds).\n[08:55:18:INFO] Test Case '-[NavigationTestCase testHistoryCrossDocumentLoad]' started.\n[08:55:20:INFO] [0525/085520.835714:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:55:26:INFO] Test Case '-[NavigationTestCase testHistoryCrossDocumentLoad]' passed (8.179 seconds).\n[08:55:26:INFO] Test Case '-[NavigationTestCase testHistoryForwardNavigation]' started.\n[08:55:29:INFO] [0525/085529.045103:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:55:35:INFO] Test Case '-[NavigationTestCase testHistoryForwardNavigation]' passed (8.392 seconds).\n[08:55:35:INFO] Test Case '-[NavigationTestCase testHistoryGoDelta]' started.\n[08:55:37:INFO] [0525/085537.428330:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:55:45:INFO] Test Case '-[NavigationTestCase testHistoryGoDelta]' passed (10.334 seconds).\n[08:55:45:INFO] Test Case '-[NavigationTestCase testHistoryGoDeltaZero]' started.\n[08:55:47:INFO] [0525/085547.787005:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:55:51:INFO] Test Case '-[NavigationTestCase testHistoryGoDeltaZero]' passed (6.051 seconds).\n[08:55:51:INFO] Test Case '-[NavigationTestCase testHistoryGoNoParameter]' started.\n[08:55:53:INFO] [0525/085553.855760:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:55:57:INFO] Test Case '-[NavigationTestCase testHistoryGoNoParameter]' passed (6.070 seconds).\n[08:55:57:INFO] Test Case '-[NavigationTestCase testHistoryGoOutOfBounds]' started.\n[08:55:59:INFO] [0525/085559.885152:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:56:04:INFO] Test Case '-[NavigationTestCase testHistoryGoOutOfBounds]' passed (6.995 seconds).\n[08:56:04:INFO] Test Case '-[NavigationTestCase testJavaScriptRedirect]' started.\n[08:56:06:INFO] [0525/085606.879948:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:56:13:INFO] Test Case '-[NavigationTestCase testJavaScriptRedirect]' passed (8.625 seconds).\n[08:56:13:INFO] Test Case '-[NavigationTestCase testRedirectRefresh]' started.\n[08:56:15:INFO] [0525/085615.499151:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:56:24:INFO] Test Case '-[NavigationTestCase testRedirectRefresh]' passed (10.940 seconds).\n[08:56:24:INFO] Test Case '-[NavigationTestCase testRedirectWindow]' started.\n[08:56:26:INFO] [0525/085626.453469:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:56:35:INFO] Test Case '-[NavigationTestCase testRedirectWindow]' passed (10.967 seconds).\n[08:56:35:INFO] Test Case '-[NavigationTestCase testRestoreHistoryToNTPAndNavigateForward]' started.\n[08:56:37:INFO] [0525/085637.410352:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:56:43:INFO] Test Case '-[NavigationTestCase testRestoreHistoryToNTPAndNavigateForward]' passed (8.275 seconds).\n[08:56:43:INFO] Test Case '-[NavigationTestCase testRestoreHistoryToWebUIAndNavigateForward]' started.\n[08:56:46:INFO] [0525/085646.853634:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:56:54:INFO] Test Case '-[NavigationTestCase testRestoreHistoryToWebUIAndNavigateForward]' passed (11.038 seconds).\n[08:56:54:INFO] Test Case '-[NavigationTestCase testWindowLocationChangeHash]' started.\n[08:56:56:INFO] [0525/085656.728872:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:57:04:INFO] Test Case '-[NavigationTestCase testWindowLocationChangeHash]' passed (9.564 seconds).\n[08:57:04:INFO] Test Case '-[NavigationTestCase testWindowLocationChangeToSameHash]' started.\n[08:57:06:INFO] [0525/085706.290384:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:57:12:INFO] Test Case '-[NavigationTestCase testWindowLocationChangeToSameHash]' passed (8.485 seconds).\n[08:57:12:INFO] Test Case '-[NavigationTestCase testWindowLocationReplaceAndChangeHash]' started.\n[08:57:14:INFO] [0525/085714.780068:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:57:20:INFO] Test Case '-[NavigationTestCase testWindowLocationReplaceAndChangeHash]' passed (8.278 seconds).\n[08:57:20:INFO] Test Suite 'NavigationTestCase' passed at 2019-05-25 08:57:20.962.\n[08:57:20:INFO] \t Executed 17 tests, with 0 failures (0 unexpected) in 149.889 (149.904) seconds\n[08:57:20:INFO] Test Suite 'ProgressIndicatorTestCase' started at 2019-05-25 08:57:20.963\n[08:57:20:INFO] [0525/085720.963937:WARNING:loopback_server.cc(835)] Loopback sync persistent state file does not exist.\n[08:57:20:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorDisappearsAfterFormSubmit]' started.\n[08:57:23:INFO] [0525/085723.056920:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:57:27:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorDisappearsAfterFormSubmit]' passed (6.048 seconds).\n[08:57:27:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorDisappearsAfterSuppressedFormPost]' started.\n[08:57:33:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorDisappearsAfterSuppressedFormPost]' passed (6.024 seconds).\n[08:57:33:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorShown]' started.\n[08:57:39:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorShown]' passed (6.343 seconds).\n[08:57:39:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorShownOnFormSubmit]' started.\n[08:57:46:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorShownOnFormSubmit]' passed (7.383 seconds).\n[08:57:46:INFO] Test Suite 'ProgressIndicatorTestCase' passed at 2019-05-25 08:57:46.767.\n[08:57:46:INFO] \t Executed 4 tests, with 0 failures (0 unexpected) in 25.798 (25.804) seconds\n[08:57:46:INFO] Test Suite 'PushAndReplaceStateNavigationTestCase' started at 2019-05-25 08:57:46.768\n[08:57:46:INFO] [0525/085746.768999:WARNING:loopback_server.cc(835)] Loopback sync persistent state file does not exist.\n[08:57:46:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryNavigatingPastNonPushedURL]' started.\n[08:57:48:INFO] [0525/085748.879446:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:58:01:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryNavigatingPastNonPushedURL]' passed (14.581 seconds).\n[08:58:01:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryPushStateThenGoBackAndForward]' started.\n[08:58:11:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryPushStateThenGoBackAndForward]' passed (9.975 seconds).\n[08:58:11:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryPushUnicodeCharacters]' started.\n[08:58:19:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryPushUnicodeCharacters]' passed (7.771 seconds).\n[08:58:19:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryReplaceStateThenGoBackAndForward]' started.\n[08:58:31:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryReplaceStateThenGoBackAndForward]' passed (12.652 seconds).\n[08:58:31:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryWithBase]' started.\n[08:58:36:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryWithBase]' passed (5.216 seconds).\n[08:58:36:INFO] Test Suite 'PushAndReplaceStateNavigationTestCase' passed at 2019-05-25 08:58:36.968.\n[08:58:36:INFO] \t Executed 5 tests, with 0 failures (0 unexpected) in 50.195 (50.200) seconds\n[08:58:36:INFO] Test Suite 'StopLoadingTestCase' started at 2019-05-25 08:58:36.968\n[08:58:36:INFO] [0525/085836.969733:WARNING:loopback_server.cc(835)] Loopback sync persistent state file does not exist.\n[08:58:36:INFO] Test Case '-[StopLoadingTestCase testStopLoading]' started.\n[08:58:47:INFO] Test Case '-[StopLoadingTestCase testStopLoading]' passed (10.949 seconds).\n[08:58:47:INFO] Test Suite 'StopLoadingTestCase' passed at 2019-05-25 08:58:47.921.\n[08:58:47:INFO] \t Executed 1 test, with 0 failures (0 unexpected) in 10.949 (10.953) seconds\n[08:58:47:INFO] Test Suite 'TabOrderTestCase' started at 2019-05-25 08:58:47.922\n[08:58:47:INFO] [0525/085847.923829:WARNING:loopback_server.cc(835)] Loopback sync persistent state file does not exist.\n[08:58:47:INFO] Test Case '-[TabOrderTestCase testChildTabOrdering]' started.\n[08:58:50:INFO] [0525/085850.037355:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:59:10:INFO] Test Case '-[TabOrderTestCase testChildTabOrdering]' passed (23.020 seconds).\n[08:59:10:INFO] Test Suite 'TabOrderTestCase' passed at 2019-05-25 08:59:10.950.\n[08:59:10:INFO] \t Executed 1 test, with 0 failures (0 unexpected) in 23.020 (23.028) seconds\n[08:59:10:INFO] Test Suite 'VisibleURLTestCase' started at 2019-05-25 08:59:10.951\n[08:59:10:INFO] [0525/085910.952379:WARNING:loopback_server.cc(835)] Loopback sync persistent state file does not exist.\n[08:59:10:INFO] Test Case '-[VisibleURLTestCase testBackForwardNavigation]' started.\n[08:59:13:INFO] [0525/085913.124255:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[08:59:23:INFO] Test Case '-[VisibleURLTestCase testBackForwardNavigation]' passed (12.452 seconds).\n[08:59:23:INFO] Test Case '-[VisibleURLTestCase testBackNavigationWithPendingReload]' started.\n[08:59:34:INFO] [0525/085934.208140:WARNING:web_state_impl.mm(668)] Script execution has failed: A JavaScript exception occurred\n[08:59:37:INFO] Test Case '-[VisibleURLTestCase testBackNavigationWithPendingReload]' passed (13.690 seconds).\n[08:59:37:INFO] Test Case '-[VisibleURLTestCase testBackNavigationWithPendingRendererInitiatedNavigation]' started.\n[08:59:46:INFO] Test Case '-[VisibleURLTestCase testBackNavigationWithPendingRendererInitiatedNavigation]' passed (9.239 seconds).\n[08:59:46:INFO] Test Case '-[VisibleURLTestCase testDoubleBackJSNavigation]' started.\n[08:59:56:INFO] Test Case '-[VisibleURLTestCase testDoubleBackJSNavigation]' passed (10.114 seconds).\n[08:59:56:INFO] Test Case '-[VisibleURLTestCase testDoubleBackNavigation]' started.\n[09:00:04:INFO] [0525/090004.074511:WARNING:web_state_impl.mm(668)] Script execution has failed: A JavaScript exception occurred\n[09:00:06:INFO] Test Case '-[VisibleURLTestCase testDoubleBackNavigation]' passed (10.539 seconds).\n[09:00:06:INFO] Test Case '-[VisibleURLTestCase testDoubleForwardNavigationToWebUIPage]' started.\n[09:00:18:INFO] Test Case '-[VisibleURLTestCase testDoubleForwardNavigationToWebUIPage]' passed (11.759 seconds).\n[09:00:18:INFO] Test Case '-[VisibleURLTestCase testHistoryNavigation]' started.\n[09:00:30:INFO] Test Case '-[VisibleURLTestCase testHistoryNavigation]' passed (11.439 seconds).\n[09:00:30:INFO] Test Case '-[VisibleURLTestCase testJSBackForwardNavigation]' started.\n[09:00:42:INFO] Test Case '-[VisibleURLTestCase testJSBackForwardNavigation]' passed (12.026 seconds).\n[09:00:42:INFO] Test Case '-[VisibleURLTestCase testJSGoNavigation]' started.\n[09:00:54:INFO] Test Case '-[VisibleURLTestCase testJSGoNavigation]' passed (11.983 seconds).\n[09:00:54:INFO] Test Case '-[VisibleURLTestCase testRendererInitiatedNavigationWithPendingBackNavigation]' started.\n[09:01:03:INFO] Test Case '-[VisibleURLTestCase testRendererInitiatedNavigationWithPendingBackNavigation]' passed (9.287 seconds).\n[09:01:03:INFO] Test Case '-[VisibleURLTestCase testStoppingPendingBackNavigationAndReload]' started.\n[09:01:19:INFO] Test Case '-[VisibleURLTestCase testStoppingPendingBackNavigationAndReload]' passed (15.908 seconds).\n[09:01:19:INFO] Test Suite 'VisibleURLTestCase' passed at 2019-05-25 09:01:19.401.\n[09:01:19:INFO] \t Executed 11 tests, with 0 failures (0 unexpected) in 128.436 (128.450) seconds\n[09:01:19:INFO] Test Suite 'WindowOpenByDOMTestCase' started at 2019-05-25 09:01:19.402\n[09:01:19:INFO] [0525/090119.403439:WARNING:loopback_server.cc(835)] Loopback sync persistent state file does not exist.\n[09:01:19:INFO] Test Case '-[WindowOpenByDOMTestCase testBlockPopupInjectedIntoOpenedWindow]' started.\n[09:01:21:INFO] [0525/090121.573557:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[09:01:25:INFO] Test Case '-[WindowOpenByDOMTestCase testBlockPopupInjectedIntoOpenedWindow]' passed (6.559 seconds).\n[09:01:25:INFO] Test Case '-[WindowOpenByDOMTestCase testCloseWindowNotOpenByDOM]' started.\n[09:01:30:INFO] Test Case '-[WindowOpenByDOMTestCase testCloseWindowNotOpenByDOM]' passed (4.999 seconds).\n[09:01:30:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTarget]' started.\n[09:01:37:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTarget]' passed (6.908 seconds).\n[09:01:37:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetMultipleTimes]' started.\n[09:01:48:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetMultipleTimes]' passed (10.708 seconds).\n[09:01:48:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetSessionStorage]' started.\n[09:01:55:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetSessionStorage]' passed (6.851 seconds).\n[09:01:55:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithDelayedClose]' started.\n[09:02:03:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithDelayedClose]' passed (8.285 seconds).\n[09:02:03:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithImmediateClose]' started.\n[09:02:09:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithImmediateClose]' passed (6.181 seconds).\n[09:02:09:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithoutUserGesture]' started.\n[09:02:15:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithoutUserGesture]' passed (5.534 seconds).\n[09:02:15:INFO] Test Case '-[WindowOpenByDOMTestCase testLocationReplaceInWindowOpenWithEmptyTarget]' started.\n[09:02:21:INFO] Test Case '-[WindowOpenByDOMTestCase testLocationReplaceInWindowOpenWithEmptyTarget]' passed (6.390 seconds).\n[09:02:21:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndAssignToHref]' started.\n[09:02:28:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndAssignToHref]' passed (6.275 seconds).\n[09:02:28:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndCallLocationAssign]' started.\n[09:02:34:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndCallLocationAssign]' passed (6.217 seconds).\n[09:02:34:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndSetLocation]' started.\n[09:02:40:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndSetLocation]' passed (6.222 seconds).\n[09:02:40:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithBlankTarget]' started.\n[09:02:46:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithBlankTarget]' passed (6.355 seconds).\n[09:02:46:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithButtonOnClick]' started.\n[09:02:53:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithButtonOnClick]' passed (6.335 seconds).\n[09:02:53:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithEmptyTarget]' started.\n[09:02:59:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithEmptyTarget]' passed (6.343 seconds).\n[09:02:59:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithMetaRefresh]' started.\n[09:03:05:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithMetaRefresh]' passed (6.256 seconds).\n[09:03:05:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithPreventDefaultLink]' started.\n[09:03:12:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithPreventDefaultLink]' passed (6.740 seconds).\n[09:03:12:INFO] Test Suite 'WindowOpenByDOMTestCase' passed at 2019-05-25 09:03:12.579.\n[09:03:12:INFO] \t Executed 17 tests, with 0 failures (0 unexpected) in 113.158 (113.177) seconds\n[09:03:12:INFO] Test Suite 'ios_chrome_web_egtests.app' passed at 2019-05-25 09:03:12.580.\n[09:03:12:INFO] \t Executed 94 tests, with 0 failures (0 unexpected) in 791.678 (793.744) seconds\n[09:03:12:INFO] Test Suite 'All tests' passed at 2019-05-25 09:03:12.581.\n[09:03:12:INFO] \t Executed 94 tests, with 0 failures (0 unexpected) in 791.678 (793.746) seconds\n[09:03:13:INFO] \n[09:03:13:INFO] \n[09:03:13:INFO] Test session results and logs:\n[09:03:13:INFO] \t/Users/chrome-bot/Library/Developer/Xcode/DerivedData/temporary-gkwagkzyztadmtakdugkpybnftel/Logs/Test/Test-Transient Testing-2019.05.25_08-49-19--0700.xcresult\n[09:03:13:INFO] \n[09:03:13:INFO] 2019-05-25 09:03:13.037 xcodebuild[12215:105947] [MT] IDETestOperationsObserverDebug: 833.761 elapsed -- Testing started completed.\n[09:03:13:INFO] 2019-05-25 09:03:13.037 xcodebuild[12215:105947] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start\n[09:03:13:INFO] 2019-05-25 09:03:13.038 xcodebuild[12215:105947] [MT] IDETestOperationsObserverDebug: 833.761 sec, +833.761 sec -- end\n[09:03:13:INFO] ** TEST EXECUTE SUCCEEDED **\n[09:03:13:INFO] \n[09:03:17:DEBUG] Finished print_process_output.\n[09:03:17:INFO] Waiting for test process to terminate.\n[09:03:17:INFO] Test process terminated.\n[09:03:17:DEBUG] Setting sigterm handler.\n[09:03:17:DEBUG] Stdout flushed after test process.\n[09:03:17:DEBUG] Processing test results.\n[09:03:17:INFO] /b/s/w/ir/src/out/Debug-iphonesimulator/iossim returned 0\n\n[09:03:17:DEBUG] Extracting test data.\n[09:03:17:DEBUG] Retrieving crash reports.\n[09:03:17:DEBUG] Retrieving derived data.\n[09:03:17:DEBUG] Making desktop screenshots.\n[09:03:17:DEBUG] Killing simulators.\n[09:03:17:INFO] Killing simulators.\n[09:03:22:DEBUG] Wiping simulator.\nDevice wiped.\n[09:03:24:DEBUG] End of tear_down.\n", "outputs_ref": { "isolated": "ea5b109cb334cc5632f8bc9ba612f5a8b372d1f2", "isolatedserver": "https://isolateserver.appspot.com", "namespace": "default-gzip" }, "run_id": "45087fbed4a40211", "server_versions": [ "4303-bae210e" ], "started_ts": "2019-05-25T15:48:53.436553", "state": "COMPLETED", "tags": [ "build_is_experimental:false", "buildername:ios-simulator-full-configs", "buildnumber:14991", "data:c34b66d09c3f53921084aa9a1467790872464e37", "device_type:iPhone X", "ios_version:11.4", "master:chromium.mac", "name:ios_chrome_web_egtests", "os:Mac-10.13.6", "os:Mac-10.14.3", "os:Mac-10.14.4", "platform:simulator", "pool:Chrome", "priority:30", "service_account:ios-isolated-tester@chops-service-accounts.iam.gserviceaccount.com", "slavename:vm124-m9", "spec_name:chromium.ci:ios-simulator-full-configs", "stepname:ios_chrome_web_egtests (iPhone X iOS 11.4) (with patch) on Mac-10.13.6", "swarming.pool.template:none", "swarming.pool.version:ccd91245d277b60137b7f72e33ea6072eedcc9f9", "test:ios_chrome_web_egtests", "user:None" ], "task_id": "45087fbed4a40210", "try_number": "1" } ] }