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_10l232m", "xcode_ios_10o45e" ] }, { "key": "cores", "value": [ "8" ] }, { "key": "cpu", "value": [ "x86", "x86-64", "x86-64-E5-2697_v2" ] }, { "key": "gce", "value": [ "0" ] }, { "key": "gpu", "value": [ "none" ] }, { "key": "id", "value": [ "vm920-m4" ] }, { "key": "mac_model", "value": [ "VMware7,1" ] }, { "key": "machine_type", "value": [ "n1-highcpu-8" ] }, { "key": "os", "value": [ "Mac", "Mac-10.13", "Mac-10.13.6" ] }, { "key": "pool", "value": [ "Chrome" ] }, { "key": "python", "value": [ "2.7.10" ] }, { "key": "server_version", "value": [ "4201-b04f7f8" ] }, { "key": "ssd", "value": [ "1" ] }, { "key": "zone", "value": [ "us", "us-golo", "us-golo-4" ] } ], "bot_id": "vm920-m4", "bot_version": "871bf8bbbd6b908d4b34ce9527c521964cfde78a5466163676e12d9e76bc4a14", "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": "LH2D9eSe-sJImw8pxSsKdnKz9LueOAM77FFBJMvP8BwC" }, { "package_name": "infra/tools/luci/vpython/mac-amd64", "path": ".swarming_module", "version": "yhDQeJa8hj64DkPAcLKVNQmNTgYsirl5_wvmnHvOz9cC" } ] }, "completed_ts": "2019-03-15T11:32:00.247100", "costs_usd": [ 0.20198416978830397 ], "created_ts": "2019-03-15T11:12:11.879637", "duration": 848.2026329040527, "modified_ts": "2019-03-15T11:32:00.247100", "name": "ios_chrome_ui_egtests (iPhone 7 iOS 11.4) shard 1/Mac-10.13.6/83285b11eb/ios12-sdk-simulator/6597", "output": "[I 2019-03-15 04:17:03] About to install Xcode 10b61 in Xcode.app for ios\n[04:17:05:INFO] Using Xcode version 10.1 build 10B61 at /b/s/w/ir/Xcode.app/Contents/Developer\n[04:17:17:INFO] Start test attempt #0 for command [xcodebuild test-without-building -xctestrun /b/s/w/ioJJb73P/run_1552648637.xctestrun -destination platform=iOS Simulator,OS=11.4,name=iPhone 7 -resultBundlePath /b/s/w/ioJJb73P/11.4 iPhone 7/attempt_0]\n[04:17:22:INFO] User defaults from command line:\nErasing all simulators.\nLaunching ['xcodebuild', 'test-without-building', '-xctestrun', '/b/s/w/ioJJb73P/run_1552648637.xctestrun', '-destination', 'platform=iOS Simulator,OS=11.4,name=iPhone 7', '-resultBundlePath', '/b/s/w/ioJJb73P/11.4 iPhone 7/attempt_0'] with env {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'MAC_CHROMIUM_TMPDIR': '/b/s/w/it7awKEV', 'LOGNAME': 'chrome-bot', 'USER': 'chrome-bot', 'HOME': '/Users/chrome-bot', 'BOTO_CONFIG': '/Users/chrome-bot/.boto', 'PATH': '/b/s/w/ir/.swarming_module_cache/vpython/b6ec90/bin:/b/s/w/ir/.swarming_module:/b/s/w/ir/.swarming_module/bin:/b/s/cipd_cache/bin:/opt/local/bin:/opt/local/sbin:/usr/local/sbin:/usr/local/git/bin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', 'SWARMING_BOT_ID': 'vm920-m4', 'VIRTUAL_ENV': '/b/s/w/ir/.swarming_module_cache/vpython/b6ec90', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ELo2bQqfXB/Render', 'SWARMING_SERVER': 'https://chromium-swarm.appspot.com', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'SWARMING_HEADLESS': '1', 'PYTHONNOUSERSITE': '1', 'LUCI_CONTEXT': '/b/s/w/it7awKEV/luci_ctx.KLQX3z.json', 'CIPD_CACHE_DIR': '/b/s/cipd_cache/cache', 'XPC_SERVICE_NAME': 'org.swarm.bot.plist', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MWCAtlgXd3/Listeners', 'VPYTHON_VIRTUALENV_ROOT': '/b/s/w/ir/.swarming_module_cache/vpython', 'SWARMING_TASK_ID': '4399deea7f790a11', 'SHELL': '/bin/bash', 'NO_GCE_CHECK': 'False', 'TMPDIR': '/b/s/w/it7awKEV', 'CIPD_PROTOCOL': 'v2', '__CF_USER_TEXT_ENCODING': '0x1F4:0x0:0x0', 'NSUnbufferedIO': 'YES'}\n[04:17:22:INFO] IDEBuildOperationResultBundlePath = /b/s/w/ioJJb73P/11.4 iPhone 7/attempt_0\n[04:17:22:INFO] IDETestRunSpecificationPath = /b/s/w/ioJJb73P/run_1552648637.xctestrun\n[04:17:22:INFO] \n[04:17:22:INFO] Testing started on 'iPhone 7'\n[04:17:23:INFO] 2019-03-15 04:17:23.633 xcodebuild[79571:1181200] IDETestOperationsObserverDebug: Writing diagnostic log for test session to:\n[04:17:23:INFO] /b/s/w/ioJJb73P/11.4 iPhone 7/attempt_0/1_Test/Diagnostics/ios_chrome_ui_egtests_module-49EBF70A-BEDC-417D-AEEB-86037DC78ED5/ios_chrome_ui_egtests_module-B78C647B-0CB8-4D6B-BBAB-D48DCA003D37/Session-ios_chrome_ui_egtests_module-2019-03-15_041723-Sm7eRP.log\n[04:17:23:INFO] 2019-03-15 04:17:23.634 xcodebuild[79571:1181168] [MT] IDETestOperationsObserverDebug: (6E4BBB1C-B41E-4DC9-B80E-8566E9A8D48D) Beginning test session ios_chrome_ui_egtests_module-6E4BBB1C-B41E-4DC9-B80E-8566E9A8D48D at 2019-03-15 04:17:23.634 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7fe59fa88ea0> {\n[04:17:23:INFO] \t\tSimDevice: iPhone 7 (2196F815-DFEB-45DE-9914-A00775FC79E7, iOS 11.4, Shutdown)\n[04:17:23:INFO] } (11.4 (15F79))\n[04:17:51:INFO] 2019-03-15 04:17:51.667 ios_chrome_ui_egtests[79692:1182780] Crash handler setup started.\n[04:17:51:INFO] 2019-03-15 04:17:51.667 ios_chrome_ui_egtests[79692:1182780] Crash handler setup completed.\n[04:17:51:INFO] 2019-03-15 04:17:51.667 ios_chrome_ui_egtests[79692:1182780] Enabling accessibility for automation on Simulator.\n[04:17:51:INFO] objc[79692]: 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 (0x1486884d0) 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 (0x14849ee38). One of the two will be used. Which one is undefined.\n[04:17:56:INFO] 2019-03-15 04:17:56.015 ios_chrome_ui_egtests[79692:1182780] Unbalanced calls to begin/end appearance transitions for <TabGridViewController: 0x7f98eb831a00>.\n[04:17:56:INFO] [0315/041756.139375:WARNING:leveldb_database.cc(106)] Unable to open /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/2196F815-DFEB-45DE-9914-A00775FC79E7/data/Containers/Data/Application/F4FCED12-A871-4165-9D5C-F8D9448ED9CA/Library/Application Support/Chromium/Default/shared_proto_db: Invalid argument: /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/2196F815-DFEB-45DE-9914-A00775FC79E7/data/Containers/Data/Application/F4FCED12-A871-4165-9D5C-F8D9448ED9CA/Library/Application Support/Chromium/Default/shared_proto_db: does not exist (create_if_missing is false)\n[04:18:02:INFO] Test Suite 'Selected tests' started at 2019-03-15 04:18:02.946\n[04:18:02:INFO] Test Suite 'ios_chrome_ui_egtests_module.xctest' started at 2019-03-15 04:18:02.947\n[04:18:02:INFO] Test Suite 'FirstRunTestCase' started at 2019-03-15 04:18:02.948\n[04:18:02:INFO] [0315/041802.961056:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[04:18:04:INFO] Test Case '-[FirstRunTestCase testDismissFirstRun]' started.\n[04:18:08:INFO] 2019-03-15 04:18:08.090 ios_chrome_ui_egtests[79692:1182780] Button touch target does not meet minimum size guidlines of (48, 48). Button: <PrimaryActionButton: 0x7f98ea512b50; baseClass = UIButton; frame = (103 599; 169 36); opaque = NO; layer = <MDCShapedShadowLayer: 0x6040002fac00>>, Touch Target: {169, 36}\n[04:18:15:INFO] Test Case '-[FirstRunTestCase testDismissFirstRun]' passed (10.381 seconds).\n[04:18:15:INFO] Test Case '-[FirstRunTestCase testPrivacy]' started.\n[04:18:22:INFO] Test Case '-[FirstRunTestCase testPrivacy]' passed (7.498 seconds).\n[04:18:22:INFO] Test Case '-[FirstRunTestCase testSignInAndTapSettingsLink]' started.\n[04:18:27:INFO] [0315/041827.089243:WARNING:sync_encryption_handler_impl.cc(1079)] Nigori had empty encryption keybag.\n[04:18:27:INFO] [0315/041827.114624:ERROR:account_tracker.cc(264)] OnOAuthError\n[04:18:27:INFO] [0315/041827.114816:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID\n[04:18:27:INFO] [0315/041827.136115:WARNING:sync_encryption_handler_impl.cc(1079)] Nigori had empty encryption keybag.\n[04:18:31:INFO] [0315/041831.173708:INFO:profile_sync_service.cc(1780)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now\n[04:18:32:INFO] [0315/041832.914359:INFO:signin_manager.cc(125)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1\n[04:18:34:INFO] Test Case '-[FirstRunTestCase testSignInAndTapSettingsLink]' passed (12.146 seconds).\n[04:18:34:INFO] Test Case '-[FirstRunTestCase testSignInAndUndo]' started.\n[04:18:39:INFO] [0315/041839.128216:ERROR:account_tracker.cc(264)] OnOAuthError\n[04:18:39:INFO] [0315/041839.128393:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID\n[04:18:40:INFO] [0315/041840.190888:INFO:signin_manager.cc(125)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1\n[04:18:44:INFO] Test Case '-[FirstRunTestCase testSignInAndUndo]' passed (9.944 seconds).\n[04:18:44:INFO] Test Case '-[FirstRunTestCase testTermsAndConditions]' started.\n[04:18:52:INFO] Test Case '-[FirstRunTestCase testTermsAndConditions]' passed (7.514 seconds).\n[04:18:52:INFO] Test Case '-[FirstRunTestCase testToggleMetricsOn]' started.\n[04:18:58:INFO] Test Case '-[FirstRunTestCase testToggleMetricsOn]' passed (6.631 seconds).\n[04:18:58:INFO] Test Suite 'FirstRunTestCase' passed at 2019-03-15 04:18:58.975.\n[04:18:58:INFO] \t Executed 6 tests, with 0 failures (0 unexpected) in 54.113 (56.027) seconds\n[04:18:58:INFO] Test Suite 'FullscreenTestCase' started at 2019-03-15 04:18:58.976\n[04:18:58:INFO] [0315/041858.977197:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[04:18:58:INFO] Test Case '-[FullscreenTestCase testChromeToChromeURLKeepsHeaderOnScreen]' started.\n[04:19:08:INFO] Test Case '-[FullscreenTestCase testChromeToChromeURLKeepsHeaderOnScreen]' passed (9.583 seconds).\n[04:19:08:INFO] Test Case '-[FullscreenTestCase testHideHeaderUserScrollLongPage]' started.\n[04:19:10:INFO] [0315/041910.762708:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:19:17:INFO] Test Case '-[FullscreenTestCase testHideHeaderUserScrollLongPage]' passed (8.434 seconds).\n[04:19:17:INFO] Test Case '-[FullscreenTestCase testLongPDFInitialState]' started.\n[04:19:22:INFO] Test Case '-[FullscreenTestCase testLongPDFInitialState]' passed (5.377 seconds).\n[04:19:22:INFO] Test Case '-[FullscreenTestCase testLongPDFScroll]' started.\n[04:19:24:INFO] 2019-03-15 04:19:24.272 ios_chrome_ui_egtests[79692:1182780] -- Earl Grey Test Disabled -- Disabled on iOS 11.\n[04:19:26:INFO] Test Case '-[FullscreenTestCase testLongPDFScroll]' passed (3.778 seconds).\n[04:19:26:INFO] Test Case '-[FullscreenTestCase testShowHeaderOnErrorPage]' started.\n[04:19:34:INFO] Test Case '-[FullscreenTestCase testShowHeaderOnErrorPage]' passed (8.224 seconds).\n[04:19:34:INFO] Test Case '-[FullscreenTestCase testShowHeaderOnNativePageLoad]' started.\n[04:19:42:INFO] Test Case '-[FullscreenTestCase testShowHeaderOnNativePageLoad]' passed (8.073 seconds).\n[04:19:42:INFO] Test Case '-[FullscreenTestCase testShowHeaderOnRegularPageLoad]' started.\n[04:19:53:INFO] Test Case '-[FullscreenTestCase testShowHeaderOnRegularPageLoad]' passed (10.721 seconds).\n[04:19:53:INFO] Test Case '-[FullscreenTestCase testShowHeaderOnReload]' started.\n[04:20:00:INFO] Test Case '-[FullscreenTestCase testShowHeaderOnReload]' passed (7.755 seconds).\n[04:20:00:INFO] Test Case '-[FullscreenTestCase testShowHeaderWhenChildTabCloses]' started.\n[04:20:05:INFO] [0315/042005.721798:WARNING:web_state_impl.mm(657)] Script execution has failed: A JavaScript exception occurred\n[04:20:10:INFO] Test Case '-[FullscreenTestCase testShowHeaderWhenChildTabCloses]' passed (10.008 seconds).\n[04:20:10:INFO] Test Case '-[FullscreenTestCase testSmallWidePDFScroll]' started.\n[04:20:18:INFO] Test Case '-[FullscreenTestCase testSmallWidePDFScroll]' passed (8.007 seconds).\n[04:20:18:INFO] Test Suite 'FullscreenTestCase' passed at 2019-03-15 04:20:18.957.\n[04:20:18:INFO] \t Executed 10 tests, with 0 failures (0 unexpected) in 79.962 (79.982) seconds\n[04:20:18:INFO] Test Suite 'HistoryUITestCase' started at 2019-03-15 04:20:18.958\n[04:20:18:INFO] [0315/042018.960514:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[04:20:18:INFO] Test Case '-[HistoryUITestCase testAccessibilityOnHistory]' started.\n[04:20:21:INFO] [0315/042021.499353:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:20:33:INFO] Test Case '-[HistoryUITestCase testAccessibilityOnHistory]' passed (14.208 seconds).\n[04:20:33:INFO] Test Case '-[HistoryUITestCase testClearBrowsingHistory]' started.\n[04:20:55:INFO] Test Case '-[HistoryUITestCase testClearBrowsingHistory]' passed (22.424 seconds).\n[04:20:55:INFO] Test Case '-[HistoryUITestCase testContextMenuCopy]' started.\n[04:21:08:INFO] 2019-03-15 04:21:08.008 ios_chrome_ui_egtests[79692:1185485] PBItemCollectionServicer connection disconnected.\n[04:21:11:INFO] Test Case '-[HistoryUITestCase testContextMenuCopy]' passed (15.856 seconds).\n[04:21:11:INFO] Test Case '-[HistoryUITestCase testContextMenuOpenInNewIncognitoTab]' started.\n[04:21:28:INFO] Test Case '-[HistoryUITestCase testContextMenuOpenInNewIncognitoTab]' passed (16.840 seconds).\n[04:21:28:INFO] Test Case '-[HistoryUITestCase testContextMenuOpenInNewTab]' started.\n[04:21:44:INFO] Test Case '-[HistoryUITestCase testContextMenuOpenInNewTab]' passed (15.934 seconds).\n[04:21:44:INFO] Test Case '-[HistoryUITestCase testDeleteHistory]' started.\n[04:22:01:INFO] Test Case '-[HistoryUITestCase testDeleteHistory]' passed (17.368 seconds).\n[04:22:01:INFO] Test Case '-[HistoryUITestCase testDisplayHistory]' started.\n[04:22:15:INFO] Test Case '-[HistoryUITestCase testDisplayHistory]' passed (13.666 seconds).\n[04:22:15:INFO] Test Case '-[HistoryUITestCase testDisplayNoHistory]' started.\n[04:22:25:INFO] Test Case '-[HistoryUITestCase testDisplayNoHistory]' passed (9.890 seconds).\n[04:22:25:INFO] Test Case '-[HistoryUITestCase testHistoryUpdateAfterBackNavigation]' started.\n[04:22:38:INFO] Test Case '-[HistoryUITestCase testHistoryUpdateAfterBackNavigation]' passed (13.536 seconds).\n[04:22:38:INFO] Test Case '-[HistoryUITestCase testSearchHistory]' started.\n[04:22:48:INFO] 2019-03-15 04:22:48.493 ios_chrome_ui_egtests[79692:1182780] +[CATransaction synchronize] called within transaction\n[04:22:48:INFO] 2019-03-15 04:22:48.519 ios_chrome_ui_egtests[79692:1182780] +[CATransaction synchronize] called within transaction\n[04:22:48:INFO] 2019-03-15 04:22:48.519 ios_chrome_ui_egtests[79692:1182780] +[CATransaction synchronize] called within transaction\n[04:22:48:INFO] 2019-03-15 04:22:48.519 ios_chrome_ui_egtests[79692:1182780] +[CATransaction synchronize] called within transaction\n[04:22:49:INFO] 2019-03-15 04:22:49.211 ios_chrome_ui_egtests[79692:1182780] Attempting to type key /.\n[04:22:49:INFO] 2019-03-15 04:22:49.417 ios_chrome_ui_egtests[79692:1182780] Tapping on key: more, numbers.\n[04:22:49:INFO] 2019-03-15 04:22:49.504 ios_chrome_ui_egtests[79692:1182780] Tapping on key: /.\n[04:22:49:INFO] 2019-03-15 04:22:49.575 ios_chrome_ui_egtests[79692:1182780] Attempting to type key f.\n[04:22:49:INFO] 2019-03-15 04:22:49.880 ios_chrome_ui_egtests[79692:1182780] Tapping on key: more, letters.\n[04:22:49:INFO] 2019-03-15 04:22:49.950 ios_chrome_ui_egtests[79692:1182780] Tapping on key: f.\n[04:22:50:INFO] 2019-03-15 04:22:50.014 ios_chrome_ui_egtests[79692:1182780] Attempting to type key i.\n[04:22:50:INFO] 2019-03-15 04:22:50.014 ios_chrome_ui_egtests[79692:1182780] Tapping on key: i.\n[04:22:50:INFO] 2019-03-15 04:22:50.067 ios_chrome_ui_egtests[79692:1182780] Attempting to type key r.\n[04:22:50:INFO] 2019-03-15 04:22:50.068 ios_chrome_ui_egtests[79692:1182780] Tapping on key: r.\n[04:22:50:INFO] 2019-03-15 04:22:50.121 ios_chrome_ui_egtests[79692:1182780] Attempting to type key s.\n[04:22:50:INFO] 2019-03-15 04:22:50.122 ios_chrome_ui_egtests[79692:1182780] Tapping on key: s.\n[04:22:50:INFO] 2019-03-15 04:22:50.173 ios_chrome_ui_egtests[79692:1182780] Attempting to type key t.\n[04:22:50:INFO] 2019-03-15 04:22:50.173 ios_chrome_ui_egtests[79692:1182780] Tapping on key: t.\n[04:22:50:INFO] 2019-03-15 04:22:50.224 ios_chrome_ui_egtests[79692:1182780] Attempting to type key u.\n[04:22:50:INFO] 2019-03-15 04:22:50.225 ios_chrome_ui_egtests[79692:1182780] Tapping on key: u.\n[04:22:50:INFO] 2019-03-15 04:22:50.277 ios_chrome_ui_egtests[79692:1182780] Attempting to type key r.\n[04:22:50:INFO] 2019-03-15 04:22:50.277 ios_chrome_ui_egtests[79692:1182780] Tapping on key: r.\n[04:22:50:INFO] 2019-03-15 04:22:50.329 ios_chrome_ui_egtests[79692:1182780] Attempting to type key l.\n[04:22:50:INFO] 2019-03-15 04:22:50.330 ios_chrome_ui_egtests[79692:1182780] Tapping on key: l.\n[04:22:50:INFO] 2019-03-15 04:22:50.381 ios_chrome_ui_egtests[79692:1182780] Attempting to type key /.\n[04:22:50:INFO] 2019-03-15 04:22:50.485 ios_chrome_ui_egtests[79692:1182780] Tapping on key: more, numbers.\n[04:22:50:INFO] 2019-03-15 04:22:50.538 ios_chrome_ui_egtests[79692:1182780] Tapping on key: /.\n[04:22:54:INFO] Test Case '-[HistoryUITestCase testSearchHistory]' passed (15.851 seconds).\n[04:22:54:INFO] Test Case '-[HistoryUITestCase testSearchLongPressOnScrimCancelsSearchController]' started.\n[04:23:11:INFO] Test Case '-[HistoryUITestCase testSearchLongPressOnScrimCancelsSearchController]' passed (16.457 seconds).\n[04:23:11:INFO] Test Suite 'HistoryUITestCase' passed at 2019-03-15 04:23:11.006.\n[04:23:11:INFO] \t Executed 11 tests, with 0 failures (0 unexpected) in 172.030 (172.048) seconds\n[04:23:11:INFO] Test Suite 'InfobarTestCase' started at 2019-03-15 04:23:11.007\n[04:23:11:INFO] [0315/042311.008034:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[04:23:11:INFO] Test Case '-[InfobarTestCase testInfobarButtonDismissal]' started.\n[04:23:13:INFO] [0315/042313.073850:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:23:20:INFO] Test Case '-[InfobarTestCase testInfobarButtonDismissal]' passed (9.547 seconds).\n[04:23:20:INFO] Test Case '-[InfobarTestCase testInfobarsDismissOnNavigate]' started.\n[04:23:30:INFO] Test Case '-[InfobarTestCase testInfobarsDismissOnNavigate]' passed (10.173 seconds).\n[04:23:30:INFO] Test Case '-[InfobarTestCase testInfobarTabSwitch]' started.\n[04:23:48:INFO] Test Case '-[InfobarTestCase testInfobarTabSwitch]' passed (17.502 seconds).\n[04:23:48:INFO] Test Case '-[InfobarTestCase testInfobarTallerLayout]' started.\n[04:23:57:INFO] Test Case '-[InfobarTestCase testInfobarTallerLayout]' passed (9.545 seconds).\n[04:23:57:INFO] Test Case '-[InfobarTestCase testInfobarTopMostVisible]' started.\n[04:24:11:INFO] Test Case '-[InfobarTestCase testInfobarTopMostVisible]' passed (13.506 seconds).\n[04:24:11:INFO] Test Case '-[InfobarTestCase testInfobarTopMostVisibleHeight]' started.\n[04:24:29:INFO] Test Case '-[InfobarTestCase testInfobarTopMostVisibleHeight]' passed (17.986 seconds).\n[04:24:29:INFO] Test Suite 'InfobarTestCase' passed at 2019-03-15 04:24:29.277.\n[04:24:29:INFO] \t Executed 6 tests, with 0 failures (0 unexpected) in 78.261 (78.270) seconds\n[04:24:29:INFO] Test Suite 'InspectUITestCase' started at 2019-03-15 04:24:29.277\n[04:24:29:INFO] [0315/042429.278771:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[04:24:29:INFO] Test Case '-[InspectUITestCase testIframeLogging]' started.\n[04:24:33:INFO] [0315/042433.971947:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:24:37:INFO] Test Case '-[InspectUITestCase testIframeLogging]' passed (7.908 seconds).\n[04:24:37:INFO] Test Case '-[InspectUITestCase testLoggingFromMultipleTabs]' started.\n[04:24:41:INFO] [0315/042441.871693:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:24:47:INFO] Test Case '-[InspectUITestCase testLoggingFromMultipleTabs]' passed (10.779 seconds).\n[04:24:47:INFO] Test Case '-[InspectUITestCase testMainFrameLogging]' started.\n[04:24:52:INFO] [0315/042452.619154:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:24:55:INFO] Test Case '-[InspectUITestCase testMainFrameLogging]' passed (7.871 seconds).\n[04:24:55:INFO] Test Case '-[InspectUITestCase testMessagesClearedOnReload]' started.\n[04:25:00:INFO] [0315/042500.500277:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:25:04:INFO] Test Case '-[InspectUITestCase testMessagesClearedOnReload]' passed (8.921 seconds).\n[04:25:04:INFO] Test Case '-[InspectUITestCase testMessagesClearedOnStopLogging]' started.\n[04:25:09:INFO] [0315/042509.383467:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:25:12:INFO] Test Case '-[InspectUITestCase testMessagesClearedOnStopLogging]' passed (7.787 seconds).\n[04:25:12:INFO] Test Case '-[InspectUITestCase testMessagesClearedOnTabClosure]' started.\n[04:25:17:INFO] [0315/042517.197010:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:25:20:INFO] Test Case '-[InspectUITestCase testMessagesClearedOnTabClosure]' passed (8.083 seconds).\n[04:25:20:INFO] Test Case '-[InspectUITestCase testStartStopLogging]' started.\n[04:25:25:INFO] Test Case '-[InspectUITestCase testStartStopLogging]' passed (4.900 seconds).\n[04:25:25:INFO] Test Suite 'InspectUITestCase' passed at 2019-03-15 04:25:25.536.\n[04:25:25:INFO] \t Executed 7 tests, with 0 failures (0 unexpected) in 56.249 (56.258) seconds\n[04:25:25:INFO] Test Suite 'JavaScriptDialogTestCase' started at 2019-03-15 04:25:25.537\n[04:25:25:INFO] [0315/042525.537976:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[04:25:25:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptAfterNewTabAnimation]' started.\n[04:25:27:INFO] [0315/042527.622944:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:25:43:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptAfterNewTabAnimation]' passed (18.447 seconds).\n[04:25:43:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptAfterShareMenu]' started.\n[04:25:45:INFO] 2019-03-15 04:25:45.753 ios_chrome_ui_egtests[79692:1182780] -- Earl Grey Test Disabled -- Disabled until EG can use share menu.\n[04:25:47:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptAfterShareMenu]' passed (3.732 seconds).\n[04:25:47:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptAlert]' started.\n[04:25:49:INFO] [0315/042549.717624:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:25:54:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptAlert]' passed (6.510 seconds).\n[04:25:54:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptAlertLoop]' started.\n[04:25:56:INFO] [0315/042556.318279:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:26:03:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptAlertLoop]' passed (8.925 seconds).\n[04:26:03:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptBehindSettings]' started.\n[04:26:05:INFO] [0315/042605.167456:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:26:15:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptBehindSettings]' passed (12.241 seconds).\n[04:26:15:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptConfirmationCancelled]' started.\n[04:26:17:INFO] [0315/042617.466790:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:26:22:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptConfirmationCancelled]' passed (6.621 seconds).\n[04:26:22:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptConfirmationOK]' started.\n[04:26:24:INFO] [0315/042624.034056:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:26:28:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptConfirmationOK]' passed (6.525 seconds).\n[04:26:28:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptPromptCancelled]' started.\n[04:26:30:INFO] [0315/042630.549301:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:26:33:INFO] 2019-03-15 04:26:33.399 ios_chrome_ui_egtests[79692:1182780] Attempting to type key t.\n[04:26:33:INFO] 2019-03-15 04:26:33.400 ios_chrome_ui_egtests[79692:1182780] Tapping on key: t.\n[04:26:33:INFO] 2019-03-15 04:26:33.453 ios_chrome_ui_egtests[79692:1182780] Attempting to type key e.\n[04:26:33:INFO] 2019-03-15 04:26:33.453 ios_chrome_ui_egtests[79692:1182780] Tapping on key: e.\n[04:26:33:INFO] 2019-03-15 04:26:33.505 ios_chrome_ui_egtests[79692:1182780] Attempting to type key s.\n[04:26:33:INFO] 2019-03-15 04:26:33.505 ios_chrome_ui_egtests[79692:1182780] Tapping on key: s.\n[04:26:33:INFO] 2019-03-15 04:26:33.557 ios_chrome_ui_egtests[79692:1182780] Attempting to type key t.\n[04:26:33:INFO] 2019-03-15 04:26:33.557 ios_chrome_ui_egtests[79692:1182780] Tapping on key: t.\n[04:26:36:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptPromptCancelled]' passed (8.434 seconds).\n[04:26:36:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptPromptOK]' started.\n[04:26:39:INFO] [0315/042639.012838:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:26:41:INFO] 2019-03-15 04:26:41.863 ios_chrome_ui_egtests[79692:1182780] Attempting to type key t.\n[04:26:41:INFO] 2019-03-15 04:26:41.863 ios_chrome_ui_egtests[79692:1182780] Tapping on key: t.\n[04:26:41:INFO] 2019-03-15 04:26:41.916 ios_chrome_ui_egtests[79692:1182780] Attempting to type key e.\n[04:26:41:INFO] 2019-03-15 04:26:41.916 ios_chrome_ui_egtests[79692:1182780] Tapping on key: e.\n[04:26:41:INFO] 2019-03-15 04:26:41.968 ios_chrome_ui_egtests[79692:1182780] Attempting to type key s.\n[04:26:41:INFO] 2019-03-15 04:26:41.969 ios_chrome_ui_egtests[79692:1182780] Tapping on key: s.\n[04:26:42:INFO] 2019-03-15 04:26:42.022 ios_chrome_ui_egtests[79692:1182780] Attempting to type key t.\n[04:26:42:INFO] 2019-03-15 04:26:42.022 ios_chrome_ui_egtests[79692:1182780] Tapping on key: t.\n[04:26:45:INFO] Test Case '-[JavaScriptDialogTestCase testShowJavaScriptPromptOK]' passed (8.444 seconds).\n[04:26:45:INFO] Test Suite 'JavaScriptDialogTestCase' passed at 2019-03-15 04:26:45.424.\n[04:26:45:INFO] \t Executed 9 tests, with 0 failures (0 unexpected) in 79.877 (79.888) seconds\n[04:26:45:INFO] Test Suite 'KeyboardCommandsTestCase' started at 2019-03-15 04:26:45.425\n[04:26:45:INFO] [0315/042645.426185:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[04:26:45:INFO] Test Case '-[KeyboardCommandsTestCase testKeyboardCommands_RecentTabsPresented]' started.\n[04:26:55:INFO] Test Case '-[KeyboardCommandsTestCase testKeyboardCommands_RecentTabsPresented]' passed (9.827 seconds).\n[04:26:55:INFO] Test Case '-[KeyboardCommandsTestCase testKeyboardCommandsNotRegistered_AddBookmarkPresented]' started.\n[04:26:57:INFO] [0315/042657.379047:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:27:09:INFO] Test Case '-[KeyboardCommandsTestCase testKeyboardCommandsNotRegistered_AddBookmarkPresented]' passed (14.470 seconds).\n[04:27:09:INFO] Test Case '-[KeyboardCommandsTestCase testKeyboardCommandsNotRegistered_BookmarksPresented]' started.\n[04:27:19:INFO] Test Case '-[KeyboardCommandsTestCase testKeyboardCommandsNotRegistered_BookmarksPresented]' passed (9.805 seconds).\n[04:27:19:INFO] Test Case '-[KeyboardCommandsTestCase testKeyboardCommandsNotRegistered_SettingsPresented]' started.\n[04:27:29:INFO] Test Case '-[KeyboardCommandsTestCase testKeyboardCommandsNotRegistered_SettingsPresented]' passed (10.071 seconds).\n[04:27:29:INFO] Test Case '-[KeyboardCommandsTestCase testKeyboardCommandsRegistered]' started.\n[04:27:33:INFO] Test Case '-[KeyboardCommandsTestCase testKeyboardCommandsRegistered]' passed (4.055 seconds).\n[04:27:33:INFO] Test Case '-[KeyboardCommandsTestCase testWebViewIsFirstResponderUponKeyPress]' started.\n[04:27:39:INFO] Test Case '-[KeyboardCommandsTestCase testWebViewIsFirstResponderUponKeyPress]' passed (5.384 seconds).\n[04:27:39:INFO] Test Suite 'KeyboardCommandsTestCase' passed at 2019-03-15 04:27:39.046.\n[04:27:39:INFO] \t Executed 6 tests, with 0 failures (0 unexpected) in 53.612 (53.621) seconds\n[04:27:39:INFO] Test Suite 'NTPHomeTestCase' started at 2019-03-15 04:27:39.047\n[04:27:39:INFO] [0315/042739.049476:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[04:27:39:INFO] Test Case '-[NTPHomeTestCase testAccessibility]' started.\n[04:27:43:INFO] Test Case '-[NTPHomeTestCase testAccessibility]' passed (4.084 seconds).\n[04:27:43:INFO] Test Case '-[NTPHomeTestCase testCollectionShortcuts]' started.\n[04:28:04:INFO] Test Case '-[NTPHomeTestCase testCollectionShortcuts]' passed (21.159 seconds).\n[04:28:04:INFO] Test Case '-[NTPHomeTestCase testFavicons]' started.\n[04:28:29:INFO] Test Case '-[NTPHomeTestCase testFavicons]' passed (24.851 seconds).\n[04:28:29:INFO] Test Case '-[NTPHomeTestCase testOmniboxPinnedWidthRotation]' started.\n[04:28:35:INFO] Test Case '-[NTPHomeTestCase testOmniboxPinnedWidthRotation]' passed (6.247 seconds).\n[04:28:35:INFO] Test Case '-[NTPHomeTestCase testOmniboxWidthRotation]' started.\n[04:28:40:INFO] Test Case '-[NTPHomeTestCase testOmniboxWidthRotation]' passed (4.854 seconds).\n[04:28:40:INFO] Test Case '-[NTPHomeTestCase testOmniboxWidthRotationBehindSettings]' started.\n[04:28:51:INFO] Test Case '-[NTPHomeTestCase testOmniboxWidthRotationBehindSettings]' passed (11.158 seconds).\n[04:28:51:INFO] Test Case '-[NTPHomeTestCase testOpeningNewTab]' started.\n[04:28:53:INFO] 2019-03-15 04:28:53.209 ios_chrome_ui_egtests[79692:1182780] -- Earl Grey Test Disabled -- Disabled due to full-configs and slimnav failures\n[04:28:55:INFO] Test Case '-[NTPHomeTestCase testOpeningNewTab]' passed (3.696 seconds).\n[04:28:55:INFO] Test Case '-[NTPHomeTestCase testOpenMultipleTabs]' started.\n[04:29:38:INFO] Test Case '-[NTPHomeTestCase testOpenMultipleTabs]' passed (43.787 seconds).\n[04:29:38:INFO] Test Case '-[NTPHomeTestCase testPositionRestored]' started.\n[04:29:40:INFO] \n[04:29:40:INFO] GMOCK WARNING:\n[04:29:40:INFO] Uninteresting mock function call - returning directly.\n[04:29:40:INFO] Function call: ClearHistory(1601-01-01 00:00:00.000 UTC, 293878-01-10 04:00:54.775 UTC, @0x7ffee433c148 8-byte object <20-5A 05-01 40-60 00-00>)\n[04:29:40:INFO] NOTE: You can safely ignore the above warning unless this call should not happen. Do not suppress it by blindly adding an EXPECT_CALL() if you don't mean to enforce the call. See https://github.com/google/googletest/blob/master/googlemock/docs/CookBook.md#knowing-when-to-expect for details.\n[04:29:41:INFO] [0315/042941.234092:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:29:46:INFO] \n[04:29:46:INFO] GMOCK WARNING:\n[04:29:46:INFO] Uninteresting mock function call - returning directly.\n[04:29:46:INFO] Function call: FetchSuggestionImageMock(@0x7ffee433b8b8 10001|chromium1, @0x7ffee433b618 8-byte object <70-0E 04-01 80-60 00-00>)\n[04:29:46:INFO] NOTE: You can safely ignore the above warning unless this call should not happen. Do not suppress it by blindly adding an EXPECT_CALL() if you don't mean to enforce the call. See https://github.com/google/googletest/blob/master/googlemock/docs/CookBook.md#knowing-when-to-expect for details.\n[04:29:46:INFO] \n[04:29:46:INFO] GMOCK WARNING:\n[04:29:46:INFO] Uninteresting mock function call - returning directly.\n[04:29:46:INFO] Function call: FetchSuggestionImageMock(@0x7ffee433b8b8 10001|chromium2, @0x7ffee433b618 8-byte object <90-77 05-01 80-60 00-00>)\n[04:29:46:INFO] NOTE: You can safely ignore the above warning unless this call should not happen. Do not suppress it by blindly adding an EXPECT_CALL() if you don't mean to enforce the call. See https://github.com/google/googletest/blob/master/googlemock/docs/CookBook.md#knowing-when-to-expect for details.\n[04:29:47:INFO] \n[04:29:47:INFO] GMOCK WARNING:\n[04:29:47:INFO] Uninteresting mock function call - returning directly.\n[04:29:47:INFO] Function call: FetchSuggestionImageMock(@0x7ffee4337bf8 10001|chromium3, @0x7ffee4337958 8-byte object <A0-02 A4-00 40-60 00-00>)\n[04:29:47:INFO] NOTE: You can safely ignore the above warning unless this call should not happen. Do not suppress it by blindly adding an EXPECT_CALL() if you don't mean to enforce the call. See https://github.com/google/googletest/blob/master/googlemock/docs/CookBook.md#knowing-when-to-expect for details.\n[04:29:50:INFO] \n[04:29:50:INFO] GMOCK WARNING:\n[04:29:50:INFO] Uninteresting mock function call - returning directly.\n[04:29:50:INFO] Function call: FetchSuggestionImageMock(@0x7ffee43384a8 10001|chromium1, @0x7ffee4338208 8-byte object <B0-C6 65-00 80-61 00-00>)\n[04:29:50:INFO] NOTE: You can safely ignore the above warning unless this call should not happen. Do not suppress it by blindly adding an EXPECT_CALL() if you don't mean to enforce the call. See https://github.com/google/googletest/blob/master/googlemock/docs/CookBook.md#knowing-when-to-expect for details.\n[04:29:50:INFO] \n[04:29:50:INFO] GMOCK WARNING:\n[04:29:50:INFO] Uninteresting mock function call - returning directly.\n[04:29:50:INFO] Function call: FetchSuggestionImageMock(@0x7ffee43384a8 10001|chromium2, @0x7ffee4338208 8-byte object <60-A1 45-00 00-61 00-00>)\n[04:29:50:INFO] NOTE: You can safely ignore the above warning unless this call should not happen. Do not suppress it by blindly adding an EXPECT_CALL() if you don't mean to enforce the call. See https://github.com/google/googletest/blob/master/googlemock/docs/CookBook.md#knowing-when-to-expect for details.\n[04:29:50:INFO] \n[04:29:50:INFO] GMOCK WARNING:\n[04:29:50:INFO] Uninteresting mock function call - returning directly.\n[04:29:50:INFO] Function call: FetchSuggestionImageMock(@0x7ffee43384a8 10001|chromium3, @0x7ffee4338208 8-byte object <30-C2 C5-00 00-61 00-00>)\n[04:29:50:INFO] NOTE: You can safely ignore the above warning unless this call should not happen. Do not suppress it by blindly adding an EXPECT_CALL() if you don't mean to enforce the call. See https://github.com/google/googletest/blob/master/googlemock/docs/CookBook.md#knowing-when-to-expect for details.\n[04:29:50:INFO] [0315/042950.888652:WARNING:crw_web_controller.mm(2907)] Unexpected message received: console.msg\n[04:29:50:INFO] [0315/042950.888897:WARNING:crw_web_controller.mm(2959)] Message from JS not handled due to invalid format\n[04:29:53:INFO] Test Case '-[NTPHomeTestCase testPositionRestored]' passed (15.051 seconds).\n[04:29:53:INFO] Test Case '-[NTPHomeTestCase testPositionRestoredWithOmniboxFocused]' started.\n[04:29:55:INFO] \n[04:29:55:INFO] GMOCK WARNING:\n[04:29:55:INFO] Uninteresting mock function call - returning directly.\n[04:29:55:INFO] Function call: ClearHistory(1601-01-01 00:00:00.000 UTC, 293878-01-10 04:00:54.775 UTC, @0x7ffee433c148 8-byte object <A0-35 E4-00 00-60 00-00>)\n[04:29:55:INFO] NOTE: You can safely ignore the above warning unless this call should not happen. Do not suppress it by blindly adding an EXPECT_CALL() if you don't mean to enforce the call. See https://github.com/google/googletest/blob/master/googlemock/docs/CookBook.md#knowing-when-to-expect for details.\n[04:29:56:INFO] [0315/042956.347447:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:30:02:INFO] \n[04:30:02:INFO] GMOCK WARNING:\n[04:30:02:INFO] Uninteresting mock function call - returning directly.\n[04:30:02:INFO] Function call: FetchSuggestionImageMock(@0x7ffee433b8b8 10001|chromium1, @0x7ffee433b618 8-byte object <D0-8F 24-01 00-60 00-00>)\n[04:30:02:INFO] NOTE: You can safely ignore the above warning unless this call should not happen. Do not suppress it by blindly adding an EXPECT_CALL() if you don't mean to enforce the call. See https://github.com/google/googletest/blob/master/googlemock/docs/CookBook.md#knowing-when-to-expect for details.\n[04:30:02:INFO] \n[04:30:02:INFO] GMOCK WARNING:\n[04:30:02:INFO] Uninteresting mock function call - returning directly.\n[04:30:02:INFO] Function call: FetchSuggestionImageMock(@0x7ffee433b8b8 10001|chromium2, @0x7ffee433b618 8-byte object <10-6A 65-00 00-60 00-00>)\n[04:30:02:INFO] NOTE: You can safely ignore the above warning unless this call should not happen. Do not suppress it by blindly adding an EXPECT_CALL() if you don't mean to enforce the call. See https://github.com/google/googletest/blob/master/googlemock/docs/CookBook.md#knowing-when-to-expect for details.\n[04:30:03:INFO] \n[04:30:03:INFO] GMOCK WARNING:\n[04:30:03:INFO] Uninteresting mock function call - returning directly.\n[04:30:03:INFO] Function call: FetchSuggestionImageMock(@0x7ffee4337bf8 10001|chromium3, @0x7ffee4337958 8-byte object <20-25 E4-00 40-61 00-00>)\n[04:30:03:INFO] NOTE: You can safely ignore the above warning unless this call should not happen. Do not suppress it by blindly adding an EXPECT_CALL() if you don't mean to enforce the call. See https://github.com/google/googletest/blob/master/googlemock/docs/CookBook.md#knowing-when-to-expect for details.\n[04:30:04:INFO] \n[04:30:04:INFO] GMOCK WARNING:\n[04:30:04:INFO] Uninteresting mock function call - returning directly.\n[04:30:04:INFO] Function call: FetchSuggestionImageMock(@0x7ffee4336798 10001|chromium4, @0x7ffee43364f8 8-byte object <90-D2 E4-00 C0-61 00-00>)\n[04:30:04:INFO] NOTE: You can safely ignore the above warning unless this call should not happen. Do not suppress it by blindly adding an EXPECT_CALL() if you don't mean to enforce the call. See https://github.com/google/googletest/blob/master/googlemock/docs/CookBook.md#knowing-when-to-expect for details.\n[04:30:05:INFO] [0315/043005.770302:WARNING:crw_web_controller.mm(2907)] Unexpected message received: console.msg\n[04:30:05:INFO] [0315/043005.770515:WARNING:crw_web_controller.mm(2959)] Message from JS not handled due to invalid format\n[04:30:07:INFO] \n[04:30:07:INFO] GMOCK WARNING:\n[04:30:07:INFO] Uninteresting mock function call - returning directly.\n[04:30:07:INFO] Function call: FetchSuggestionImageMock(@0x7ffee43384a8 10001|chromium1, @0x7ffee4338208 8-byte object <90-E4 04-01 C0-61 00-00>)\n[04:30:07:INFO] NOTE: You can safely ignore the above warning unless this call should not happen. Do not suppress it by blindly adding an EXPECT_CALL() if you don't mean to enforce the call. See https://github.com/google/googletest/blob/master/googlemock/docs/CookBook.md#knowing-when-to-expect for details.\n[04:30:07:INFO] \n[04:30:07:INFO] GMOCK WARNING:\n[04:30:07:INFO] Uninteresting mock function call - returning directly.\n[04:30:07:INFO] Function call: FetchSuggestionImageMock(@0x7ffee43384a8 10001|chromium2, @0x7ffee4338208 8-byte object <40-F8 64-00 C0-61 00-00>)\n[04:30:07:INFO] NOTE: You can safely ignore the above warning unless this call should not happen. Do not suppress it by blindly adding an EXPECT_CALL() if you don't mean to enforce the call. See https://github.com/google/googletest/blob/master/googlemock/docs/CookBook.md#knowing-when-to-expect for details.\n[04:30:07:INFO] \n[04:30:07:INFO] GMOCK WARNING:\n[04:30:07:INFO] Uninteresting mock function call - returning directly.\n[04:30:07:INFO] Function call: FetchSuggestionImageMock(@0x7ffee43384a8 10001|chromium3, @0x7ffee4338208 8-byte object <E0-8E C4-00 C0-61 00-00>)\n[04:30:07:INFO] NOTE: You can safely ignore the above warning unless this call should not happen. Do not suppress it by blindly adding an EXPECT_CALL() if you don't mean to enforce the call. See https://github.com/google/googletest/blob/master/googlemock/docs/CookBook.md#knowing-when-to-expect for details.\n[04:30:11:INFO] Test Case '-[NTPHomeTestCase testPositionRestoredWithOmniboxFocused]' passed (17.085 seconds).\n[04:30:11:INFO] Test Case '-[NTPHomeTestCase testPromoTap]' started.\n[04:30:22:INFO] Test Case '-[NTPHomeTestCase testPromoTap]' passed (11.076 seconds).\n[04:30:22:INFO] Test Case '-[NTPHomeTestCase testTapFakeOmnibox]' started.\n[04:30:25:INFO] 2019-03-15 04:30:25.382 ios_chrome_ui_egtests[79692:1182780] Attempting to type key h.\n[04:30:25:INFO] 2019-03-15 04:30:25.383 ios_chrome_ui_egtests[79692:1182780] Tapping on key: h.\n[04:30:25:INFO] 2019-03-15 04:30:25.506 ios_chrome_ui_egtests[79692:1182780] Attempting to type key t.\n[04:30:25:INFO] 2019-03-15 04:30:25.506 ios_chrome_ui_egtests[79692:1182780] Tapping on key: t.\n[04:30:25:INFO] 2019-03-15 04:30:25.587 ios_chrome_ui_egtests[79692:1182780] Attempting to type key t.\n[04:30:25:INFO] 2019-03-15 04:30:25.587 ios_chrome_ui_egtests[79692:1182780] Tapping on key: t.\n[04:30:25:INFO] 2019-03-15 04:30:25.674 ios_chrome_ui_egtests[79692:1182780] Attempting to type key p.\n[04:30:25:INFO] 2019-03-15 04:30:25.675 ios_chrome_ui_egtests[79692:1182780] Tapping on key: p.\n[04:30:25:INFO] 2019-03-15 04:30:25.760 ios_chrome_ui_egtests[79692:1182780] Attempting to type key :.\n[04:30:25:INFO] 2019-03-15 04:30:25.866 ios_chrome_ui_egtests[79692:1182780] Tapping on key: more, numbers.\n[04:30:25:INFO] 2019-03-15 04:30:25.921 ios_chrome_ui_egtests[79692:1182780] Tapping on key: :.\n[04:30:26:INFO] 2019-03-15 04:30:26.022 ios_chrome_ui_egtests[79692:1182780] Attempting to type key /.\n[04:30:26:INFO] 2019-03-15 04:30:26.023 ios_chrome_ui_egtests[79692:1182780] Tapping on key: /.\n[04:30:26:INFO] [0315/043026.072424:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 9\n[04:30:26:INFO] 2019-03-15 04:30:26.115 ios_chrome_ui_egtests[79692:1182780] Attempting to type key /.\n[04:30:26:INFO] 2019-03-15 04:30:26.117 ios_chrome_ui_egtests[79692:1182780] Tapping on key: /.\n[04:30:26:INFO] [0315/043026.166801:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 11\n[04:30:26:INFO] 2019-03-15 04:30:26.209 ios_chrome_ui_egtests[79692:1182780] Attempting to type key 1.\n[04:30:26:INFO] 2019-03-15 04:30:26.210 ios_chrome_ui_egtests[79692:1182780] Tapping on key: 1.\n[04:30:26:INFO] [0315/043026.268398:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 13\n[04:30:26:INFO] 2019-03-15 04:30:26.302 ios_chrome_ui_egtests[79692:1182780] Attempting to type key 2.\n[04:30:26:INFO] 2019-03-15 04:30:26.302 ios_chrome_ui_egtests[79692:1182780] Tapping on key: 2.\n[04:30:26:INFO] 2019-03-15 04:30:26.393 ios_chrome_ui_egtests[79692:1182780] Attempting to type key 7.\n[04:30:26:INFO] 2019-03-15 04:30:26.394 ios_chrome_ui_egtests[79692:1182780] Tapping on key: 7.\n[04:30:26:INFO] 2019-03-15 04:30:26.493 ios_chrome_ui_egtests[79692:1182780] Attempting to type key ..\n[04:30:26:INFO] 2019-03-15 04:30:26.495 ios_chrome_ui_egtests[79692:1182780] Tapping on key: ..\n[04:30:26:INFO] 2019-03-15 04:30:26.593 ios_chrome_ui_egtests[79692:1182780] Attempting to type key 0.\n[04:30:26:INFO] 2019-03-15 04:30:26.594 ios_chrome_ui_egtests[79692:1182780] Tapping on key: 0.\n[04:30:26:INFO] 2019-03-15 04:30:26.690 ios_chrome_ui_egtests[79692:1182780] Attempting to type key ..\n[04:30:26:INFO] 2019-03-15 04:30:26.692 ios_chrome_ui_egtests[79692:1182780] Tapping on key: ..\n[04:30:26:INFO] 2019-03-15 04:30:26.780 ios_chrome_ui_egtests[79692:1182780] Attempting to type key 0.\n[04:30:26:INFO] 2019-03-15 04:30:26.781 ios_chrome_ui_egtests[79692:1182780] Tapping on key: 0.\n[04:30:26:INFO] 2019-03-15 04:30:26.866 ios_chrome_ui_egtests[79692:1182780] Attempting to type key ..\n[04:30:26:INFO] 2019-03-15 04:30:26.869 ios_chrome_ui_egtests[79692:1182780] Tapping on key: ..\n[04:30:26:INFO] [0315/043026.918993:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 23\n[04:30:26:INFO] 2019-03-15 04:30:26.956 ios_chrome_ui_egtests[79692:1182780] Attempting to type key 1.\n[04:30:26:INFO] 2019-03-15 04:30:26.956 ios_chrome_ui_egtests[79692:1182780] Tapping on key: 1.\n[04:30:27:INFO] [0315/043027.015529:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 25\n[04:30:27:INFO] 2019-03-15 04:30:27.043 ios_chrome_ui_egtests[79692:1182780] Attempting to type key :.\n[04:30:27:INFO] 2019-03-15 04:30:27.044 ios_chrome_ui_egtests[79692:1182780] Tapping on key: :.\n[04:30:27:INFO] 2019-03-15 04:30:27.133 ios_chrome_ui_egtests[79692:1182780] Attempting to type key 5.\n[04:30:27:INFO] 2019-03-15 04:30:27.134 ios_chrome_ui_egtests[79692:1182780] Tapping on key: 5.\n[04:30:27:INFO] 2019-03-15 04:30:27.210 ios_chrome_ui_egtests[79692:1182780] Attempting to type key 6.\n[04:30:27:INFO] 2019-03-15 04:30:27.211 ios_chrome_ui_egtests[79692:1182780] Tapping on key: 6.\n[04:30:27:INFO] 2019-03-15 04:30:27.283 ios_chrome_ui_egtests[79692:1182780] Attempting to type key 3.\n[04:30:27:INFO] 2019-03-15 04:30:27.284 ios_chrome_ui_egtests[79692:1182780] Tapping on key: 3.\n[04:30:27:INFO] 2019-03-15 04:30:27.364 ios_chrome_ui_egtests[79692:1182780] Attempting to type key 5.\n[04:30:27:INFO] 2019-03-15 04:30:27.365 ios_chrome_ui_egtests[79692:1182780] Tapping on key: 5.\n[04:30:27:INFO] 2019-03-15 04:30:27.434 ios_chrome_ui_egtests[79692:1182780] Attempting to type key 9.\n[04:30:27:INFO] 2019-03-15 04:30:27.435 ios_chrome_ui_egtests[79692:1182780] Tapping on key: 9.\n[04:30:27:INFO] 2019-03-15 04:30:27.492 ios_chrome_ui_egtests[79692:1182780] Attempting to type key /.\n[04:30:27:INFO] 2019-03-15 04:30:27.493 ios_chrome_ui_egtests[79692:1182780] Tapping on key: /.\n[04:30:27:INFO] 2019-03-15 04:30:27.552 ios_chrome_ui_egtests[79692:1182780] Attempting to type key t.\n[04:30:27:INFO] 2019-03-15 04:30:27.860 ios_chrome_ui_egtests[79692:1182780] Tapping on key: more, letters.\n[04:30:27:INFO] 2019-03-15 04:30:27.913 ios_chrome_ui_egtests[79692:1182780] Tapping on key: t.\n[04:30:27:INFO] 2019-03-15 04:30:27.971 ios_chrome_ui_egtests[79692:1182780] Attempting to type key e.\n[04:30:27:INFO] 2019-03-15 04:30:27.971 ios_chrome_ui_egtests[79692:1182780] Tapping on key: e.\n[04:30:28:INFO] 2019-03-15 04:30:28.027 ios_chrome_ui_egtests[79692:1182780] Attempting to type key s.\n[04:30:28:INFO] 2019-03-15 04:30:28.029 ios_chrome_ui_egtests[79692:1182780] Tapping on key: s.\n[04:30:28:INFO] 2019-03-15 04:30:28.086 ios_chrome_ui_egtests[79692:1182780] Attempting to type key t.\n[04:30:28:INFO] 2019-03-15 04:30:28.086 ios_chrome_ui_egtests[79692:1182780] Tapping on key: t.\n[04:30:28:INFO] 2019-03-15 04:30:28.142 ios_chrome_ui_egtests[79692:1182780] Attempting to type key -.\n[04:30:28:INFO] 2019-03-15 04:30:28.245 ios_chrome_ui_egtests[79692:1182780] Tapping on key: more, numbers.\n[04:30:28:INFO] 2019-03-15 04:30:28.299 ios_chrome_ui_egtests[79692:1182780] Tapping on key: -.\n[04:30:28:INFO] 2019-03-15 04:30:28.357 ios_chrome_ui_egtests[79692:1182780] Attempting to type key p.\n[04:30:28:INFO] 2019-03-15 04:30:28.666 ios_chrome_ui_egtests[79692:1182780] Tapping on key: more, letters.\n[04:30:28:INFO] 2019-03-15 04:30:28.720 ios_chrome_ui_egtests[79692:1182780] Tapping on key: p.\n[04:30:28:INFO] 2019-03-15 04:30:28.779 ios_chrome_ui_egtests[79692:1182780] Attempting to type key a.\n[04:30:28:INFO] 2019-03-15 04:30:28.779 ios_chrome_ui_egtests[79692:1182780] Tapping on key: a.\n[04:30:28:INFO] 2019-03-15 04:30:28.835 ios_chrome_ui_egtests[79692:1182780] Attempting to type key g.\n[04:30:28:INFO] 2019-03-15 04:30:28.836 ios_chrome_ui_egtests[79692:1182780] Tapping on key: g.\n[04:30:28:INFO] 2019-03-15 04:30:28.891 ios_chrome_ui_egtests[79692:1182780] Attempting to type key e.\n[04:30:28:INFO] 2019-03-15 04:30:28.891 ios_chrome_ui_egtests[79692:1182780] Tapping on key: e.\n[04:30:28:INFO] 2019-03-15 04:30:28.948 ios_chrome_ui_egtests[79692:1182780] Attempting to type key ..\n[04:30:28:INFO] 2019-03-15 04:30:28.951 ios_chrome_ui_egtests[79692:1182780] Tapping on key: ..\n[04:30:29:INFO] 2019-03-15 04:30:29.009 ios_chrome_ui_egtests[79692:1182780] Attempting to type key h.\n[04:30:29:INFO] 2019-03-15 04:30:29.010 ios_chrome_ui_egtests[79692:1182780] Tapping on key: h.\n[04:30:29:INFO] 2019-03-15 04:30:29.069 ios_chrome_ui_egtests[79692:1182780] Attempting to type key t.\n[04:30:29:INFO] 2019-03-15 04:30:29.069 ios_chrome_ui_egtests[79692:1182780] Tapping on key: t.\n[04:30:29:INFO] 2019-03-15 04:30:29.140 ios_chrome_ui_egtests[79692:1182780] Attempting to type key m.\n[04:30:29:INFO] 2019-03-15 04:30:29.141 ios_chrome_ui_egtests[79692:1182780] Tapping on key: m.\n[04:30:29:INFO] 2019-03-15 04:30:29.199 ios_chrome_ui_egtests[79692:1182780] Attempting to type key l.\n[04:30:29:INFO] 2019-03-15 04:30:29.200 ios_chrome_ui_egtests[79692:1182780] Tapping on key: l.\n[04:30:29:INFO] 2019-03-15 04:30:29.259 ios_chrome_ui_egtests[79692:1182780] Attempting to type key\n[04:30:29:INFO] .\n[04:30:29:INFO] 2019-03-15 04:30:29.260 ios_chrome_ui_egtests[79692:1182780] Tapping on key: Go.\n[04:30:29:INFO] [0315/043029.632068:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[04:30:32:INFO] Test Case '-[NTPHomeTestCase testTapFakeOmnibox]' passed (10.342 seconds).\n[04:30:32:INFO] Test Case '-[NTPHomeTestCase testTapFakeOmniboxScroll]' started.\n[04:30:38:INFO] Test Case '-[NTPHomeTestCase testTapFakeOmniboxScroll]' passed (6.482 seconds).\n[04:30:38:INFO] Test Case '-[NTPHomeTestCase testTapFakeOmniboxScrollScrolled]' started.\n[04:30:46:INFO] Test Case '-[NTPHomeTestCase testTapFakeOmniboxScrollScrolled]' passed (7.569 seconds).\n[04:30:46:INFO] Test Case '-[NTPHomeTestCase testTapOmniboxSearchButtonLogsCorrectly]' started.\n[04:30:50:INFO] Test Case '-[NTPHomeTestCase testTapOmniboxSearchButtonLogsCorrectly]' passed (4.352 seconds).\n[04:30:50:INFO] Test Case '-[NTPHomeTestCase testTapSearchButtonFakeOmniboxScrolled]' started.\n[04:30:57:INFO] Test Case '-[NTPHomeTestCase testTapSearchButtonFakeOmniboxScrolled]' passed (6.982 seconds).\n[04:30:57:INFO] Test Suite 'NTPHomeTestCase' passed at 2019-03-15 04:30:57.867.\n[04:30:57:INFO] \t Executed 16 tests, with 0 failures (0 unexpected) in 198.776 (198.820) seconds\n[04:30:57:INFO] Test Suite 'ios_chrome_ui_egtests_module.xctest' passed at 2019-03-15 04:30:57.868.\n[04:30:57:INFO] \t Executed 71 tests, with 0 failures (0 unexpected) in 772.881 (774.921) seconds\n[04:30:57:INFO] Test Suite 'Selected tests' passed at 2019-03-15 04:30:57.869.\n[04:30:57:INFO] \t Executed 71 tests, with 0 failures (0 unexpected) in 772.881 (774.923) seconds\n[04:30:58:INFO] \n[04:30:58:INFO] \n[04:30:58:INFO] Test session log:\n[04:30:58:INFO] \t/b/s/w/ioJJb73P/11.4 iPhone 7/attempt_0/1_Test/Diagnostics/ios_chrome_ui_egtests_module-49EBF70A-BEDC-417D-AEEB-86037DC78ED5/ios_chrome_ui_egtests_module-B78C647B-0CB8-4D6B-BBAB-D48DCA003D37/Session-ios_chrome_ui_egtests_module-2019-03-15_041723-Sm7eRP.log\n[04:30:58:INFO] \n[04:30:58:INFO] 2019-03-15 04:30:58.327 xcodebuild[79571:1181168] [MT] IDETestOperationsObserverDebug: 815.332 elapsed -- Testing started completed.\n[04:30:58:INFO] 2019-03-15 04:30:58.327 xcodebuild[79571:1181168] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start\n[04:30:58:INFO] 2019-03-15 04:30:58.327 xcodebuild[79571:1181168] [MT] IDETestOperationsObserverDebug: 815.332 sec, +815.332 sec -- end\n[04:30:58:INFO] ** TEST EXECUTE SUCCEEDED **\n[04:30:58:INFO] \n[04:31:02:INFO] Command ['xcodebuild', 'test-without-building', '-xctestrun', '/b/s/w/ioJJb73P/run_1552648637.xctestrun', '-destination', 'platform=iOS Simulator,OS=11.4,name=iPhone 7', '-resultBundlePath', '/b/s/w/ioJJb73P/11.4 iPhone 7/attempt_0'] finished with 0\n[04:31:02:DEBUG] Test ended.\n[04:31:02:DEBUG] Extracting test data.\n[04:31:02:DEBUG] Retrieving crash reports.\n[04:31:02:DEBUG] Retrieving derived data.\n[04:31:02:DEBUG] Making desktop screenshots.\n[04:31:02:DEBUG] Killing simulators.\n[04:31:07:DEBUG] Wiping simulator.\nDevice wiped.\n[04:31:10:DEBUG] End of tear_down.\n", "outputs_ref": { "isolated": "595fc521852511e3c4ff426d8943ec35f5e19dbb", "isolatedserver": "https://isolateserver.appspot.com", "namespace": "default-gzip" }, "run_id": "4399deea7f790a11", "server_versions": [ "4201-b04f7f8" ], "started_ts": "2019-03-15T11:16:40.198441", "state": "COMPLETED", "tags": [ "build_is_experimental:false", "buildername:ios12-sdk-simulator", "buildnumber:6597", "data:83285b11eb014a28061abd7ddbecae9386130373", "device_type:iPhone 7", "ios_version:11.4", "master:chromium.fyi", "name:ios_chrome_ui_egtests", "os:Mac-10.13.6", "platform:simulator", "pool:Chrome", "priority:35", "service_account:ios-isolated-tester@chops-service-accounts.iam.gserviceaccount.com", "slavename:build111-m9", "spec_name:chromium.ci:ios12-sdk-simulator", "stepname:ios_chrome_ui_egtests (iPhone 7 iOS 11.4) shard 1 on Mac-10.13.6", "swarming.pool.template:none", "swarming.pool.version:9cd6701b5128278fb953d98a57c0128375244005", "test:ios_chrome_ui_egtests", "user:None" ], "task_id": "4399deea7f790a10", "try_number": "1" } ] }