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": [ "vm555-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": [ "4267-53b17d5" ] }, { "key": "ssd", "value": [ "1" ] }, { "key": "zone", "value": [ "us", "us-golo", "us-golo-4" ] } ], "bot_id": "vm555-m4", "bot_version": "bd68e04e43fc4d1b7b5b65890a29c5d5bae55ab1423851733f92abd7e13dda14", "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-04-24T14:52:15.461832", "costs_usd": [ 0.44934285465190293 ], "created_ts": "2019-04-24T14:18:00.693423", "duration": 1976.3973860740662, "modified_ts": "2019-04-24T14:52:15.461832", "name": "ios_chrome_settings_egtests (iPhone X iOS 11.4)/Mac-10.13.6/8c43d4425d/ios-slimnav/150", "output": "[I 2019-04-24 07:18:29] About to install Xcode 10b61 in Xcode.app for ios\n[07:18:30:INFO] Using Xcode version 10.1 build 10B61 at /b/s/w/ir/Xcode.app/Contents/Developer\nDevice wiped.\n[07:18:40:DEBUG] Setting sigterm handler.\n[07:18:42:INFO] User defaults from command line:\n[07:18:42:INFO] IDETestRunSpecificationPath = /var/folders/2j/22s2gz0s7hn48k32d47clxf80000gm/T/FFD42B0D-DA56-4460-8306-2682BC1F2DA6\n[07:18:42:INFO] \n[07:18:42:INFO] Testing started on 'iPhone X'\n[07:18:42:INFO] 2019-04-24 07:18:42.490 xcodebuild[44883:1665383] IDETestOperationsObserverDebug: Writing diagnostic log for test session to:\n[07:18:42:INFO] /Users/chrome-bot/Library/Developer/Xcode/DerivedData/temporary-acsndxmisffmvxhcaifoiwyxtinm/Logs/Test/Test-Transient Testing-2019.04.24_07-18-42--0700.xcresult/1_Test/Diagnostics/ios_chrome_settings_egtests_module-766216FA-B1F2-423E-BCAA-E01E721519A9/ios_chrome_settings_egtests_module-BF17B695-4BF2-45B4-90A7-1239FB08C725/Session-ios_chrome_settings_egtests_module-2019-04-24_071842-ds8xd5.log\n[07:18:42:INFO] 2019-04-24 07:18:42.490 xcodebuild[44883:1665375] [MT] IDETestOperationsObserverDebug: (6193A8C5-41E7-4835-9DFF-6D09DEB95E93) Beginning test session ios_chrome_settings_egtests_module-6193A8C5-41E7-4835-9DFF-6D09DEB95E93 at 2019-04-24 07:18:42.490 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7fc45a0bab20> {\n[07:18:42:INFO] \t\tSimDevice: iPhone X (EAFD338B-99B8-4AE4-AB8E-79467A966E0F, iOS 11.4, Shutdown)\n[07:18:42:INFO] } (11.4 (15F79))\n[07:19:09:INFO] 2019-04-24 07:19:09.951 ios_chrome_settings_egtests[45018:1667082] Crash handler setup started.\n[07:19:09:INFO] 2019-04-24 07:19:09.952 ios_chrome_settings_egtests[45018:1667082] Crash handler setup completed.\n[07:19:09:INFO] 2019-04-24 07:19:09.952 ios_chrome_settings_egtests[45018:1667082] Enabling accessibility for automation on Simulator.\n[07:19:10:INFO] objc[45018]: 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 (0x1462b44d0) 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 (0x1460cae38). One of the two will be used. Which one is undefined.\n[07:19:13:INFO] 2019-04-24 07:19:13.718 ios_chrome_settings_egtests[45018:1667082] Unbalanced calls to begin/end appearance transitions for <TabGridViewController: 0x7ffd25040600>.\n[07:19:14:INFO] [0424/071914.403608:WARNING:leveldb_database.cc(106)] Unable to open /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/EAFD338B-99B8-4AE4-AB8E-79467A966E0F/data/Containers/Data/Application/E8F9C44C-B2AD-42C6-BB57-0331E4564E0B/Library/Application Support/Chromium/Default/shared_proto_db: Invalid argument: /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/EAFD338B-99B8-4AE4-AB8E-79467A966E0F/data/Containers/Data/Application/E8F9C44C-B2AD-42C6-BB57-0331E4564E0B/Library/Application Support/Chromium/Default/shared_proto_db: does not exist (create_if_missing is false)\n[07:19:14:INFO] [0424/071914.562792:ERROR:send_tab_to_self_client_service_ios.mm(97)] Not implemented reached in virtual void send_tab_to_self::SendTabToSelfClientServiceIOS::EntriesRemovedRemotely(const std::vector<std::string> &)\n[07:19:20:INFO] Test Suite 'All tests' started at 2019-04-24 07:19:20.998\n[07:19:21:INFO] Test Suite 'ios_chrome_settings_egtests.app' started at 2019-04-24 07:19:20.999\n[07:19:21:INFO] Test Suite 'AccountCollectionsTestCase' started at 2019-04-24 07:19:21.000\n[07:19:21:INFO] [0424/071921.011159:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[07:19:22:INFO] Test Case '-[AccountCollectionsTestCase testMDMError]' started.\n[07:19:33:INFO] 2019-04-24 07:19:33.394 ios_chrome_settings_egtests[45018:1667082] Button touch target does not meet minimum size guidlines of (48, 48). Button: <MDCFlatButton: 0x7ffd22cbf6f0; baseClass = UIButton; frame = (16 726; 86 36); opaque = NO; layer = <MDCShapedShadowLayer: 0x6000008f0780>>, Touch Target: {86, 36}\n[07:19:35:INFO] \n[07:19:35:INFO] GMOCK WARNING:\n[07:19:35:INFO] Uninteresting mock function call - returning default value.\n[07:19:35:INFO] Function call: GetMDMDeviceStatus(1)\n[07:19:35:INFO] Returns: 0\n[07:19:35: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[07:19:35:INFO] [0424/071935.018232:ERROR:account_info_fetcher.cc(59)] OnGetTokenFailure: Unexpected service response ()\n[07:19:35:INFO] [0424/071935.018421:WARNING:account_fetcher_service.cc(333)] Failed to get UserInfo for foo1ID\n[07:19:35:INFO] \n[07:19:35:INFO] GMOCK WARNING:\n[07:19:35:INFO] Uninteresting mock function call - returning default value.\n[07:19:35:INFO] Function call: GetMDMDeviceStatus(1)\n[07:19:35:INFO] Returns: 0\n[07:19:35: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[07:19:35:INFO] \n[07:19:35:INFO] GMOCK WARNING:\n[07:19:35:INFO] Uninteresting mock function call - returning default value.\n[07:19:35:INFO] Function call: GetMDMDeviceStatus(1)\n[07:19:35:INFO] Returns: 0\n[07:19:35: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[07:19:35:INFO] [0424/071935.019218:ERROR:account_tracker.cc(240)] AccessTokenFetched error: Unexpected service response ()\n[07:19:35:INFO] [0424/071935.019386:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID\n[07:19:35:INFO] \n[07:19:35:INFO] GMOCK WARNING:\n[07:19:35:INFO] Uninteresting mock function call - returning default value.\n[07:19:35:INFO] Function call: GetMDMDeviceStatus(1)\n[07:19:35:INFO] Returns: 0\n[07:19:35: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[07:19:35:INFO] \n[07:19:35:INFO] GMOCK WARNING:\n[07:19:35:INFO] Uninteresting mock function call - returning default value.\n[07:19:35:INFO] Function call: GetMDMDeviceStatus(1)\n[07:19:35:INFO] Returns: 0\n[07:19:35: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[07:19:35:INFO] [0424/071935.020045:ERROR:sync_auth_manager.cc(488)] Unexpected persistent error: Unexpected service response ()\n[07:19:35:INFO] \n[07:19:35:INFO] GMOCK WARNING:\n[07:19:35:INFO] Uninteresting mock function call - returning default value.\n[07:19:35:INFO] Function call: GetMDMDeviceStatus(1)\n[07:19:35:INFO] Returns: 0\n[07:19:35: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[07:19:35:INFO] \n[07:19:35:INFO] GMOCK WARNING:\n[07:19:35:INFO] Uninteresting mock function call - returning default value.\n[07:19:35:INFO] Function call: GetMDMDeviceStatus(1)\n[07:19:35:INFO] Returns: 0\n[07:19:35: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[07:19:35:INFO] \n[07:19:35:INFO] GMOCK WARNING:\n[07:19:35:INFO] Uninteresting mock function call - returning default value.\n[07:19:35:INFO] Function call: GetMDMDeviceStatus(1)\n[07:19:35:INFO] Returns: 0\n[07:19:35: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[07:19:35:INFO] \n[07:19:35:INFO] GMOCK WARNING:\n[07:19:35:INFO] Uninteresting mock function call - returning default value.\n[07:19:35:INFO] Function call: GetMDMDeviceStatus(1)\n[07:19:35:INFO] Returns: 0\n[07:19:35: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[07:19:36:INFO] \n[07:19:36:INFO] GMOCK WARNING:\n[07:19:36:INFO] Uninteresting mock function call - returning default value.\n[07:19:36:INFO] Function call: GetMDMDeviceStatus(1)\n[07:19:36:INFO] Returns: 0\n[07:19:36: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[07:19:36:INFO] \n[07:19:36:INFO] GMOCK WARNING:\n[07:19:36:INFO] Uninteresting mock function call - returning default value.\n[07:19:36:INFO] Function call: GetMDMDeviceStatus(1)\n[07:19:36:INFO] Returns: 0\n[07:19:36: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[07:19:36:INFO] [0424/071936.870266:ERROR:sync_auth_manager.cc(488)] Unexpected persistent error: Unexpected service response ()\n[07:19:41:INFO] \n[07:19:41:INFO] GMOCK WARNING:\n[07:19:41:INFO] Uninteresting mock function call - returning default value.\n[07:19:41:INFO] Function call: GetMDMDeviceStatus(1)\n[07:19:41:INFO] Returns: 0\n[07:19:41: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[07:19:41:INFO] \n[07:19:41:INFO] GMOCK WARNING:\n[07:19:41:INFO] Uninteresting mock function call - returning default value.\n[07:19:41:INFO] Function call: GetMDMDeviceStatus(1)\n[07:19:41:INFO] Returns: 0\n[07:19:41: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[07:19:41:INFO] [0424/071941.160587:ERROR:sync_auth_manager.cc(488)] Unexpected persistent error: Unexpected service response ()\n[07:19:47:INFO] \n[07:19:47:INFO] GMOCK WARNING:\n[07:19:47:INFO] Uninteresting mock function call - returning default value.\n[07:19:47:INFO] Function call: GetMDMDeviceStatus(1)\n[07:19:47:INFO] Returns: 0\n[07:19: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[07:19:47:INFO] \n[07:19:47:INFO] GMOCK WARNING:\n[07:19:47:INFO] Uninteresting mock function call - returning default value.\n[07:19:47:INFO] Function call: GetMDMDeviceStatus(1)\n[07:19:47:INFO] Returns: 0\n[07:19: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[07:19:47:INFO] [0424/071947.723939:ERROR:sync_auth_manager.cc(488)] Unexpected persistent error: Unexpected service response ()\n[07:19:49:INFO] [0424/071949.776335:INFO:signin_manager.cc(122)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1\n[07:19:49:INFO] [0424/071949.814525:ERROR:gcm_driver_desktop.cc(978)] Unable to delete the InstanceID token: cannot start the GCM Client\n[07:19:49:INFO] [0424/071949.815901:ERROR:gcm_driver_desktop.cc(1062)] Unable to remove the InstanceID data: cannot start the GCM Client\n[07:19:50:INFO] [0424/071950.189546:WARNING:gaia_auth_fetcher.cc(882)] Could not reach Google Accounts servers: errno -12\n[07:19:51:INFO] [0424/071951.346446:WARNING:gaia_auth_fetcher.cc(882)] Could not reach Google Accounts servers: errno -12\n[07:19:53:INFO] Test Case '-[AccountCollectionsTestCase testMDMError]' passed (30.766 seconds).\n[07:19:53:INFO] Test Case '-[AccountCollectionsTestCase testSignInDisconnectCancelled]' started.\n[07:19:54:INFO] [0424/071954.919630:WARNING:gaia_auth_fetcher.cc(882)] Could not reach Google Accounts servers: errno -12\n[07:20:03:INFO] [0424/072003.745958:WARNING:gaia_auth_fetcher.cc(882)] Could not reach Google Accounts servers: errno -12\n[07:20:05:INFO] [0424/072005.110781:WARNING:sync_encryption_handler_impl.cc(1091)] Nigori had empty encryption keybag.\n[07:20:05:INFO] [0424/072005.147990:WARNING:sync_encryption_handler_impl.cc(1091)] Nigori had empty encryption keybag.\n[07:20:05:INFO] [0424/072005.160425:ERROR:account_info_fetcher.cc(75)] OnOAuthError\n[07:20:05:INFO] [0424/072005.160635:WARNING:account_fetcher_service.cc(333)] Failed to get UserInfo for foo1ID\n[07:20:05:INFO] [0424/072005.201285:ERROR:account_tracker.cc(264)] OnOAuthError\n[07:20:05:INFO] [0424/072005.201511:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID\n[07:20:06:INFO] [0424/072006.564738:INFO:profile_sync_service.cc(1734)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now\n[07:20:23:INFO] [0424/072023.468821:INFO:signin_manager.cc(122)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1\n[07:20:23:INFO] [0424/072023.474957:ERROR:gcm_driver_desktop.cc(978)] Unable to delete the InstanceID token: cannot start the GCM Client\n[07:20:23:INFO] [0424/072023.475200:ERROR:gcm_driver_desktop.cc(1062)] Unable to remove the InstanceID data: cannot start the GCM Client\n[07:20:26:INFO] Test Case '-[AccountCollectionsTestCase testSignInDisconnectCancelled]' passed (33.266 seconds).\n[07:20:26:INFO] Test Case '-[AccountCollectionsTestCase testSignInPopUpAccountOnDisconnectAccount]' started.\n[07:20:30:INFO] [0424/072030.875235:WARNING:gaia_auth_fetcher.cc(882)] Could not reach Google Accounts servers: errno -12\n[07:20:38:INFO] [0424/072038.933751:ERROR:account_info_fetcher.cc(75)] OnOAuthError\n[07:20:38:INFO] [0424/072038.933940:WARNING:account_fetcher_service.cc(333)] Failed to get UserInfo for foo1ID\n[07:20:38:INFO] [0424/072038.968097:ERROR:account_tracker.cc(264)] OnOAuthError\n[07:20:38:INFO] [0424/072038.968305:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID\n[07:20:40:INFO] [0424/072040.388513:INFO:profile_sync_service.cc(1734)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now\n[07:20:40:INFO] [0424/072040.496306:WARNING:session_sync_bridge.cc(227)] Dropping modification to local session.\n[07:20:53:INFO] [0424/072053.526610:INFO:signin_manager.cc(122)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1\n[07:20:53:INFO] [0424/072053.632037:ERROR:gcm_driver_desktop.cc(978)] Unable to delete the InstanceID token: cannot start the GCM Client\n[07:20:53:INFO] [0424/072053.632299:ERROR:gcm_driver_desktop.cc(1062)] Unable to remove the InstanceID data: cannot start the GCM Client\n[07:20:59:INFO] Test Case '-[AccountCollectionsTestCase testSignInPopUpAccountOnDisconnectAccount]' passed (33.019 seconds).\n[07:20:59:INFO] Test Case '-[AccountCollectionsTestCase testSignInPopUpAccountOnSyncSettings]' started.\n[07:21:11:INFO] [0424/072111.545612:ERROR:account_info_fetcher.cc(75)] OnOAuthError\n[07:21:11:INFO] [0424/072111.545799:WARNING:account_fetcher_service.cc(333)] Failed to get UserInfo for foo1ID\n[07:21:11:INFO] [0424/072111.573338:ERROR:account_tracker.cc(264)] OnOAuthError\n[07:21:11:INFO] [0424/072111.573519:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID\n[07:21:13:INFO] [0424/072113.257168:INFO:profile_sync_service.cc(1734)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now\n[07:21:13:INFO] [0424/072113.365226:WARNING:session_sync_bridge.cc(227)] Dropping modification to local session.\n[07:21:28:INFO] [0424/072128.603500:INFO:signin_manager.cc(122)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1\n[07:21:28:INFO] [0424/072128.770874:ERROR:gcm_driver_desktop.cc(978)] Unable to delete the InstanceID token: cannot start the GCM Client\n[07:21:28:INFO] [0424/072128.771123:ERROR:gcm_driver_desktop.cc(1062)] Unable to remove the InstanceID data: cannot start the GCM Client\n[07:21:34:INFO] Test Case '-[AccountCollectionsTestCase testSignInPopUpAccountOnSyncSettings]' passed (35.027 seconds).\n[07:21:34:INFO] Test Case '-[AccountCollectionsTestCase testSignInReloadOnRemoveAccount]' started.\n[07:21:42:INFO] [0424/072142.089295:WARNING:gaia_auth_fetcher.cc(882)] Could not reach Google Accounts servers: errno -12\n[07:21:46:INFO] [0424/072146.314305:ERROR:account_info_fetcher.cc(75)] OnOAuthError\n[07:21:46:INFO] [0424/072146.314470:WARNING:account_fetcher_service.cc(333)] Failed to get UserInfo for foo1ID\n[07:21:46:INFO] [0424/072146.341725:ERROR:account_tracker.cc(264)] OnOAuthError\n[07:21:46:INFO] [0424/072146.341904:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID\n[07:21:46:INFO] [0424/072146.370670:ERROR:account_info_fetcher.cc(75)] OnOAuthError\n[07:21:46:INFO] [0424/072146.370854:WARNING:account_fetcher_service.cc(333)] Failed to get UserInfo for foo2ID\n[07:21:46:INFO] [0424/072146.400825:ERROR:account_tracker.cc(264)] OnOAuthError\n[07:21:46:INFO] [0424/072146.400995:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo2ID\n[07:21:47:INFO] [0424/072147.672319:INFO:profile_sync_service.cc(1734)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now\n[07:21:47:INFO] [0424/072147.783736:WARNING:session_sync_bridge.cc(227)] Dropping modification to local session.\n[07:22:05:INFO] [0424/072205.089439:INFO:signin_manager.cc(122)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1\n[07:22:05:INFO] [0424/072205.096676:ERROR:gcm_driver_desktop.cc(978)] Unable to delete the InstanceID token: cannot start the GCM Client\n[07:22:05:INFO] [0424/072205.096888:ERROR:gcm_driver_desktop.cc(1062)] Unable to remove the InstanceID data: cannot start the GCM Client\n[07:22:08:INFO] Test Case '-[AccountCollectionsTestCase testSignInReloadOnRemoveAccount]' passed (33.561 seconds).\n[07:22:08:INFO] Test Case '-[AccountCollectionsTestCase testSignInReloadSyncOnForgetIdentity]' started.\n[07:22:19:INFO] [0424/072219.882122:ERROR:account_info_fetcher.cc(75)] OnOAuthError\n[07:22:19:INFO] [0424/072219.882371:WARNING:account_fetcher_service.cc(333)] Failed to get UserInfo for foo1ID\n[07:22:19:INFO] [0424/072219.907518:ERROR:account_tracker.cc(264)] OnOAuthError\n[07:22:19:INFO] [0424/072219.907746:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID\n[07:22:19:INFO] [0424/072219.931020:ERROR:account_info_fetcher.cc(75)] OnOAuthError\n[07:22:19:INFO] [0424/072219.931206:WARNING:account_fetcher_service.cc(333)] Failed to get UserInfo for foo2ID\n[07:22:19:INFO] [0424/072219.961010:ERROR:account_tracker.cc(264)] OnOAuthError\n[07:22:19:INFO] [0424/072219.961216:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo2ID\n[07:22:21:INFO] [0424/072221.289750:INFO:profile_sync_service.cc(1734)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now\n[07:22:21:INFO] [0424/072221.408849:WARNING:session_sync_bridge.cc(227)] Dropping modification to local session.\n[07:22:37:INFO] [0424/072237.540154:INFO:signin_manager.cc(122)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1\n[07:22:37:INFO] [0424/072237.548857:ERROR:gcm_driver_desktop.cc(978)] Unable to delete the InstanceID token: cannot start the GCM Client\n[07:22:37:INFO] [0424/072237.549111:ERROR:gcm_driver_desktop.cc(1062)] Unable to remove the InstanceID data: cannot start the GCM Client\n[07:22:41:INFO] Test Case '-[AccountCollectionsTestCase testSignInReloadSyncOnForgetIdentity]' passed (32.465 seconds).\n[07:22:41:INFO] Test Case '-[AccountCollectionsTestCase testSignOutOnRemoveAccount]' started.\n[07:22:52:INFO] [0424/072252.654231:ERROR:account_info_fetcher.cc(75)] OnOAuthError\n[07:22:52:INFO] [0424/072252.654409:WARNING:account_fetcher_service.cc(333)] Failed to get UserInfo for foo1ID\n[07:22:52:INFO] [0424/072252.697572:ERROR:account_tracker.cc(264)] OnOAuthError\n[07:22:52:INFO] [0424/072252.697758:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID\n[07:22:54:INFO] [0424/072254.025305:INFO:profile_sync_service.cc(1734)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now\n[07:22:54:INFO] [0424/072254.142127:WARNING:session_sync_bridge.cc(227)] Dropping modification to local session.\n[07:23:08:INFO] [0424/072308.598505:INFO:signin_manager.cc(122)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1\n[07:23:08:INFO] [0424/072308.696165:ERROR:gcm_driver_desktop.cc(978)] Unable to delete the InstanceID token: cannot start the GCM Client\n[07:23:08:INFO] [0424/072308.696429:ERROR:gcm_driver_desktop.cc(1062)] Unable to remove the InstanceID data: cannot start the GCM Client\n[07:23:15:INFO] Test Case '-[AccountCollectionsTestCase testSignOutOnRemoveAccount]' passed (34.530 seconds).\n[07:23:15:INFO] Test Case '-[AccountCollectionsTestCase testSyncItemWithPassphraseRequired]' started.\n[07:23:27:INFO] [0424/072327.092618:ERROR:account_info_fetcher.cc(75)] OnOAuthError\n[07:23:27:INFO] [0424/072327.092810:WARNING:account_fetcher_service.cc(333)] Failed to get UserInfo for foo1ID\n[07:23:27:INFO] [0424/072327.120625:ERROR:account_tracker.cc(264)] OnOAuthError\n[07:23:27:INFO] [0424/072327.120818:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID\n[07:23:28:INFO] [0424/072328.377282:INFO:profile_sync_service.cc(1734)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now\n[07:23:28:INFO] [0424/072328.474423:WARNING:session_sync_bridge.cc(227)] Dropping modification to local session.\n[07:23:38:INFO] [0424/072338.318678:ERROR:data_type_manager_impl.cc(38)] Passwords cryptographer error was encountered:\n[07:23:40:INFO] [0424/072340.822020:INFO:signin_manager.cc(122)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1\n[07:23:40:INFO] [0424/072340.980414:ERROR:gcm_driver_desktop.cc(978)] Unable to delete the InstanceID token: cannot start the GCM Client\n[07:23:40:INFO] [0424/072340.980689:ERROR:gcm_driver_desktop.cc(1062)] Unable to remove the InstanceID data: cannot start the GCM Client\n[07:23:44:INFO] Test Case '-[AccountCollectionsTestCase testSyncItemWithPassphraseRequired]' passed (28.809 seconds).\n[07:23:44:INFO] Test Case '-[AccountCollectionsTestCase testSyncItemWithSyncingMessage]' started.\n[07:23:55:INFO] [0424/072355.758282:ERROR:account_info_fetcher.cc(75)] OnOAuthError\n[07:23:55:INFO] [0424/072355.758453:WARNING:account_fetcher_service.cc(333)] Failed to get UserInfo for foo1ID\n[07:23:55:INFO] [0424/072355.790168:ERROR:account_tracker.cc(264)] OnOAuthError\n[07:23:55:INFO] [0424/072355.790356:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID\n[07:23:57:INFO] [0424/072357.107181:INFO:profile_sync_service.cc(1734)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now\n[07:23:57:INFO] [0424/072357.205908:WARNING:session_sync_bridge.cc(227)] Dropping modification to local session.\n[07:24:09:INFO] [0424/072409.464977:INFO:signin_manager.cc(122)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1\n[07:24:09:INFO] [0424/072409.574324:ERROR:gcm_driver_desktop.cc(978)] Unable to delete the InstanceID token: cannot start the GCM Client\n[07:24:09:INFO] [0424/072409.574568:ERROR:gcm_driver_desktop.cc(1062)] Unable to remove the InstanceID data: cannot start the GCM Client\n[07:24:12:INFO] Test Case '-[AccountCollectionsTestCase testSyncItemWithSyncingMessage]' passed (28.579 seconds).\n[07:24:12:INFO] Test Suite 'AccountCollectionsTestCase' passed at 2019-04-24 07:24:12.927.\n[07:24:12:INFO] \t Executed 9 tests, with 0 failures (0 unexpected) in 290.023 (291.927) seconds\n[07:24:12:INFO] Test Suite 'AutofillCreditCardSettingsTestCase' started at 2019-04-24 07:24:12.928\n[07:24:12:INFO] [0424/072412.930021:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[07:24:12:INFO] Test Case '-[AutofillCreditCardSettingsTestCase testAccessibilityOnCreditCardEditPage]' started.\n[07:24:36:INFO] Test Case '-[AutofillCreditCardSettingsTestCase testAccessibilityOnCreditCardEditPage]' passed (23.856 seconds).\n[07:24:36:INFO] Test Case '-[AutofillCreditCardSettingsTestCase testAccessibilityOnCreditCardViewPage]' started.\n[07:24:59:INFO] Test Case '-[AutofillCreditCardSettingsTestCase testAccessibilityOnCreditCardViewPage]' passed (22.726 seconds).\n[07:24:59:INFO] Test Case '-[AutofillCreditCardSettingsTestCase testCreditCardViewPage]' started.\n[07:25:22:INFO] Test Case '-[AutofillCreditCardSettingsTestCase testCreditCardViewPage]' passed (22.734 seconds).\n[07:25:22:INFO] Test Case '-[AutofillCreditCardSettingsTestCase testListViewEditMode]' started.\n[07:25:32:INFO] [0424/072532.907963:WARNING:gaia_auth_fetcher.cc(882)] Could not reach Google Accounts servers: errno -12\n[07:25:40:INFO] Test Case '-[AutofillCreditCardSettingsTestCase testListViewEditMode]' passed (18.339 seconds).\n[07:25:40:INFO] Test Case '-[AutofillCreditCardSettingsTestCase testToggleCreditCardSwitch]' started.\n[07:26:01:INFO] Test Case '-[AutofillCreditCardSettingsTestCase testToggleCreditCardSwitch]' passed (21.220 seconds).\n[07:26:01:INFO] Test Suite 'AutofillCreditCardSettingsTestCase' passed at 2019-04-24 07:26:01.820.\n[07:26:01:INFO] \t Executed 5 tests, with 0 failures (0 unexpected) in 108.876 (108.892) seconds\n[07:26:01:INFO] Test Suite 'AutofillProfileSettingsTestCase' started at 2019-04-24 07:26:01.821\n[07:26:01:INFO] [0424/072601.822609:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[07:26:01:INFO] Test Case '-[AutofillProfileSettingsTestCase testAccessibilityOnAutofillProfileEditPage]' started.\n[07:26:26:INFO] Test Case '-[AutofillProfileSettingsTestCase testAccessibilityOnAutofillProfileEditPage]' passed (24.716 seconds).\n[07:26:26:INFO] Test Case '-[AutofillProfileSettingsTestCase testAccessibilityOnAutofillProfileViewPage]' started.\n[07:26:48:INFO] Test Case '-[AutofillProfileSettingsTestCase testAccessibilityOnAutofillProfileViewPage]' passed (22.411 seconds).\n[07:26:48:INFO] Test Case '-[AutofillProfileSettingsTestCase testAutofillProfileEditing]' started.\n[07:27:39:INFO] Test Case '-[AutofillProfileSettingsTestCase testAutofillProfileEditing]' passed (50.405 seconds).\n[07:27:39:INFO] Test Case '-[AutofillProfileSettingsTestCase testListViewEditMode]' started.\n[07:27:59:INFO] Test Case '-[AutofillProfileSettingsTestCase testListViewEditMode]' passed (19.649 seconds).\n[07:27:59:INFO] Test Case '-[AutofillProfileSettingsTestCase testToggleAutofillProfileSwitch]' started.\n[07:28:19:INFO] Test Case '-[AutofillProfileSettingsTestCase testToggleAutofillProfileSwitch]' passed (20.284 seconds).\n[07:28:19:INFO] Test Suite 'AutofillProfileSettingsTestCase' passed at 2019-04-24 07:28:19.296.\n[07:28:19:INFO] \t Executed 5 tests, with 0 failures (0 unexpected) in 137.464 (137.475) seconds\n[07:28:19:INFO] Test Suite 'BlockPopupsTestCase' started at 2019-04-24 07:28:19.297\n[07:28:19:INFO] [0424/072819.299440:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[07:28:19:INFO] Test Case '-[BlockPopupsTestCase testAccessibilityOfBlockPopupSettings]' started.\n[07:28:42:INFO] Test Case '-[BlockPopupsTestCase testAccessibilityOfBlockPopupSettings]' passed (23.224 seconds).\n[07:28:42:INFO] Test Case '-[BlockPopupsTestCase testPopupsAllowed]' started.\n[07:28:45:INFO] [0424/072845.253713:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[07:28:49:INFO] Test Case '-[BlockPopupsTestCase testPopupsAllowed]' passed (6.839 seconds).\n[07:28:49:INFO] Test Case '-[BlockPopupsTestCase testPopupsBlocked]' started.\n[07:28:55:INFO] Test Case '-[BlockPopupsTestCase testPopupsBlocked]' passed (6.492 seconds).\n[07:28:55:INFO] Test Case '-[BlockPopupsTestCase testSettingsPageWithExceptions]' started.\n[07:29:27:INFO] Test Case '-[BlockPopupsTestCase testSettingsPageWithExceptions]' passed (31.286 seconds).\n[07:29:27:INFO] Test Suite 'BlockPopupsTestCase' passed at 2019-04-24 07:29:27.150.\n[07:29:27:INFO] \t Executed 4 tests, with 0 failures (0 unexpected) in 67.841 (67.853) seconds\n[07:29:27:INFO] Test Suite 'ClearBrowsingDataSettingsTestCase' started at 2019-04-24 07:29:27.152\n[07:29:27:INFO] [0424/072927.153507:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[07:29:27:INFO] Test Case '-[ClearBrowsingDataSettingsTestCase testOpenClearBrowsingDataDialogNewUI]' started.\n[07:29:44:INFO] Test Case '-[ClearBrowsingDataSettingsTestCase testOpenClearBrowsingDataDialogNewUI]' passed (17.698 seconds).\n[07:29:44:INFO] Test Case '-[ClearBrowsingDataSettingsTestCase testOpenClearBrowsingDataDialogOldUI]' started.\n[07:30:01:INFO] Test Case '-[ClearBrowsingDataSettingsTestCase testOpenClearBrowsingDataDialogOldUI]' passed (16.646 seconds).\n[07:30:01:INFO] Test Suite 'ClearBrowsingDataSettingsTestCase' passed at 2019-04-24 07:30:01.513.\n[07:30:01:INFO] \t Executed 2 tests, with 0 failures (0 unexpected) in 34.344 (34.361) seconds\n[07:30:01:INFO] Test Suite 'PasswordsSettingsTestCase' started at 2019-04-24 07:30:01.513\n[07:30:01:INFO] [0424/073001.517532:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[07:30:01:INFO] Test Case '-[PasswordsSettingsTestCase testAccessibilityOnPasswords]' started.\n[07:30:26:INFO] Test Case '-[PasswordsSettingsTestCase testAccessibilityOnPasswords]' passed (25.073 seconds).\n[07:30:26:INFO] Test Case '-[PasswordsSettingsTestCase testBlacklistedFormDeletionInDetailView]' started.\n[07:30:56:INFO] Test Case '-[PasswordsSettingsTestCase testBlacklistedFormDeletionInDetailView]' passed (29.519 seconds).\n[07:30:56:INFO] Test Case '-[PasswordsSettingsTestCase testCancelDeletionInDetailView]' started.\n[07:31:27:INFO] Test Case '-[PasswordsSettingsTestCase testCancelDeletionInDetailView]' passed (31.195 seconds).\n[07:31:27:INFO] Test Case '-[PasswordsSettingsTestCase testCanEditPasswordsFromASearch]' started.\n[07:31:50:INFO] Test Case '-[PasswordsSettingsTestCase testCanEditPasswordsFromASearch]' passed (23.313 seconds).\n[07:31:50:INFO] Test Case '-[PasswordsSettingsTestCase testCantSearchPasswordsWhileInEditMode]' started.\n[07:32:05:INFO] Test Case '-[PasswordsSettingsTestCase testCantSearchPasswordsWhileInEditMode]' passed (15.225 seconds).\n[07:32:05:INFO] Test Case '-[PasswordsSettingsTestCase testCopyPasswordMenuItem]' started.\n[07:32:23:INFO] 2019-04-24 07:32:23.029 ios_chrome_settings_egtests[45018:1667082] Returning local object of class NSString\n[07:32:35:INFO] Test Case '-[PasswordsSettingsTestCase testCopyPasswordMenuItem]' passed (29.534 seconds).\n[07:32:35:INFO] Test Case '-[PasswordsSettingsTestCase testCopyPasswordToast]' started.\n[07:32:51:INFO] 2019-04-24 07:32:51.081 ios_chrome_settings_egtests[45018:1667082] Returning local object of class NSString\n[07:32:51:INFO] 2019-04-24 07:32:51.093 ios_chrome_settings_egtests[45018:1674023] PBItemCollectionServicer connection disconnected.\n[07:33:05:INFO] Test Case '-[PasswordsSettingsTestCase testCopyPasswordToast]' passed (30.242 seconds).\n[07:33:05:INFO] Test Case '-[PasswordsSettingsTestCase testCopyPasswordToastNoReauth]' started.\n[07:33:29:INFO] Test Case '-[PasswordsSettingsTestCase testCopyPasswordToastNoReauth]' passed (23.994 seconds).\n[07:33:29:INFO] Test Case '-[PasswordsSettingsTestCase testCopySiteMenuItem]' started.\n[07:33:46:INFO] 2019-04-24 07:33:46.472 ios_chrome_settings_egtests[45018:1667082] Returning local object of class NSString\n[07:33:46:INFO] 2019-04-24 07:33:46.487 ios_chrome_settings_egtests[45018:1674289] PBItemCollectionServicer connection disconnected.\n[07:33:58:INFO] Test Case '-[PasswordsSettingsTestCase testCopySiteMenuItem]' passed (29.127 seconds).\n[07:33:58:INFO] Test Case '-[PasswordsSettingsTestCase testCopySiteToast]' started.\n[07:34:13:INFO] 2019-04-24 07:34:13.029 ios_chrome_settings_egtests[45018:1667082] Returning local object of class NSString\n[07:34:13:INFO] 2019-04-24 07:34:13.039 ios_chrome_settings_egtests[45018:1674582] PBItemCollectionServicer connection disconnected.\n[07:34:24:INFO] Test Case '-[PasswordsSettingsTestCase testCopySiteToast]' passed (25.353 seconds).\n[07:34:24:INFO] Test Case '-[PasswordsSettingsTestCase testCopyUsernameMenuItem]' started.\n[07:34:38:INFO] 2019-04-24 07:34:38.713 ios_chrome_settings_egtests[45018:1667082] Returning local object of class NSString\n[07:34:38:INFO] 2019-04-24 07:34:38.720 ios_chrome_settings_egtests[45018:1674829] PBItemCollectionServicer connection disconnected.\n[07:34:49:INFO] Test Case '-[PasswordsSettingsTestCase testCopyUsernameMenuItem]' passed (25.556 seconds).\n[07:34:49:INFO] Test Case '-[PasswordsSettingsTestCase testCopyUsernameToast]' started.\n[07:35:03:INFO] 2019-04-24 07:35:03.133 ios_chrome_settings_egtests[45018:1667082] Returning local object of class NSString\n[07:35:03:INFO] 2019-04-24 07:35:03.140 ios_chrome_settings_egtests[45018:1674919] PBItemCollectionServicer connection disconnected.\n[07:35:14:INFO] Test Case '-[PasswordsSettingsTestCase testCopyUsernameToast]' passed (24.565 seconds).\n[07:35:14:INFO] Test Case '-[PasswordsSettingsTestCase testDeletionInListView]' started.\n[07:35:36:INFO] Test Case '-[PasswordsSettingsTestCase testDeletionInListView]' passed (22.647 seconds).\n[07:35:36:INFO] Test Case '-[PasswordsSettingsTestCase testDuplicatedSavedFormDeletionInDetailView]' started.\n[07:36:04:INFO] Test Case '-[PasswordsSettingsTestCase testDuplicatedSavedFormDeletionInDetailView]' passed (27.729 seconds).\n[07:36:04:INFO] Test Case '-[PasswordsSettingsTestCase testEditButtonUpdateOnDeletion]' started.\n[07:36:26:INFO] Test Case '-[PasswordsSettingsTestCase testEditButtonUpdateOnDeletion]' passed (21.979 seconds).\n[07:36:26:INFO] Test Case '-[PasswordsSettingsTestCase testEditMode]' started.\n[07:36:46:INFO] Test Case '-[PasswordsSettingsTestCase testEditMode]' passed (19.915 seconds).\n[07:36:46:INFO] Test Case '-[PasswordsSettingsTestCase testExportFlow]' started.\n[07:37:06:INFO] Test Case '-[PasswordsSettingsTestCase testExportFlow]' passed (20.402 seconds).\n[07:37:06:INFO] Test Case '-[PasswordsSettingsTestCase testFederated]' started.\n[07:37:19:INFO] [0424/073719.783431:WARNING:gaia_auth_fetcher.cc(882)] Could not reach Google Accounts servers: errno -12\n[07:37:37:INFO] Test Case '-[PasswordsSettingsTestCase testFederated]' passed (30.425 seconds).\n[07:37:37:INFO] Test Case '-[PasswordsSettingsTestCase testLayoutBlacklisted]' started.\n[07:38:04:INFO] Test Case '-[PasswordsSettingsTestCase testLayoutBlacklisted]' passed (27.500 seconds).\n[07:38:04:INFO] Test Case '-[PasswordsSettingsTestCase testLayoutFederated]' started.\n[07:38:36:INFO] Test Case '-[PasswordsSettingsTestCase testLayoutFederated]' passed (31.895 seconds).\n[07:38:36:INFO] Test Case '-[PasswordsSettingsTestCase testLayoutNormal]' started.\n[07:39:10:INFO] Test Case '-[PasswordsSettingsTestCase testLayoutNormal]' passed (33.896 seconds).\n[07:39:10:INFO] Test Case '-[PasswordsSettingsTestCase testManyPasswords]' started.\n[07:39:37:INFO] Test Case '-[PasswordsSettingsTestCase testManyPasswords]' passed (26.657 seconds).\n[07:39:37:INFO] Test Case '-[PasswordsSettingsTestCase testOpenSettingsFromManualFallback]' started.\n[07:39:39:INFO] [0424/073939.811058:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[07:39:41:INFO] 2019-04-24 07:39:41.855 ios_chrome_settings_egtests[45018:1667082] API error: <_UIKBCompatInputView: 0x7ffd22c8bf20; frame = (0 0; 0 0); layer = <CALayer: 0x600001235800>> returned 0 width, assuming UIViewNoIntrinsicMetric\n[07:39:41:INFO] 2019-04-24 07:39:41.855 ios_chrome_settings_egtests[45018:1667082] API error: <_UIKBCompatInputView: 0x7ffd22c8bf20; frame = (0 0; 0 0); layer = <CALayer: 0x600001235800>> returned 0 width, assuming UIViewNoIntrinsicMetric\n[07:39:50:INFO] Test Case '-[PasswordsSettingsTestCase testOpenSettingsFromManualFallback]' passed (12.830 seconds).\n[07:39:50:INFO] Test Case '-[PasswordsSettingsTestCase testPrefToggle]' started.\n[07:40:10:INFO] Test Case '-[PasswordsSettingsTestCase testPrefToggle]' passed (20.748 seconds).\n[07:40:10:INFO] Test Case '-[PasswordsSettingsTestCase testSavedFormDeletionInDetailView]' started.\n[07:40:37:INFO] Test Case '-[PasswordsSettingsTestCase testSavedFormDeletionInDetailView]' passed (26.652 seconds).\n[07:40:37:INFO] Test Case '-[PasswordsSettingsTestCase testSearchAndDeleteAllPasswords]' started.\n[07:41:04:INFO] Test Case '-[PasswordsSettingsTestCase testSearchAndDeleteAllPasswords]' passed (26.599 seconds).\n[07:41:04:INFO] Test Case '-[PasswordsSettingsTestCase testSearchPasswords]' started.\n[07:41:18:INFO] 2019-04-24 07:41:18.724 ios_chrome_settings_egtests[45018:1667082] Attempting to type key 2.\n[07:41:18:INFO] 2019-04-24 07:41:18.930 ios_chrome_settings_egtests[45018:1667082] Tapping on key: more, numbers.\n[07:41:19:INFO] 2019-04-24 07:41:19.034 ios_chrome_settings_egtests[45018:1667082] Tapping on key: 2.\n[07:41:28:INFO] Test Case '-[PasswordsSettingsTestCase testSearchPasswords]' passed (24.768 seconds).\n[07:41:28:INFO] Test Case '-[PasswordsSettingsTestCase testShowHidePasswordMenuItem]' started.\n[07:41:55:INFO] Test Case '-[PasswordsSettingsTestCase testShowHidePasswordMenuItem]' passed (27.046 seconds).\n[07:41:55:INFO] Test Case '-[PasswordsSettingsTestCase testShowPasswordToastAuthFailed]' started.\n[07:42:19:INFO] Test Case '-[PasswordsSettingsTestCase testShowPasswordToastAuthFailed]' passed (23.260 seconds).\n[07:42:19:INFO] Test Case '-[PasswordsSettingsTestCase testShowPasswordToastAuthSucceeded]' started.\n[07:42:43:INFO] Test Case '-[PasswordsSettingsTestCase testShowPasswordToastAuthSucceeded]' passed (24.098 seconds).\n[07:42:43:INFO] Test Case '-[PasswordsSettingsTestCase testShowPasswordToastNoReauth]' started.\n[07:43:05:INFO] Test Case '-[PasswordsSettingsTestCase testShowPasswordToastNoReauth]' passed (21.769 seconds).\n[07:43:05:INFO] Test Case '-[PasswordsSettingsTestCase testStoredEntriesAlwaysShown]' started.\n[07:43:31:INFO] Test Case '-[PasswordsSettingsTestCase testStoredEntriesAlwaysShown]' passed (26.173 seconds).\n[07:43:31:INFO] Test Suite 'PasswordsSettingsTestCase' passed at 2019-04-24 07:43:31.243.\n[07:43:31:INFO] \t Executed 32 tests, with 0 failures (0 unexpected) in 809.686 (809.730) seconds\n[07:43:31:INFO] Test Suite 'SettingsTestCase' started at 2019-04-24 07:43:31.244\n[07:43:31:INFO] [0424/074331.245253:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[07:43:31:INFO] Test Case '-[SettingsTestCase testAccessibilityOnAddresses]' started.\n[07:43:48:INFO] Test Case '-[SettingsTestCase testAccessibilityOnAddresses]' passed (16.982 seconds).\n[07:43:48:INFO] Test Case '-[SettingsTestCase testAccessibilityOnBandwidthManagementSettingsPage]' started.\n[07:44:05:INFO] Test Case '-[SettingsTestCase testAccessibilityOnBandwidthManagementSettingsPage]' passed (16.832 seconds).\n[07:44:05:INFO] Test Case '-[SettingsTestCase testAccessibilityOnBandwidthPreloadWebpagesSettingsPage]' started.\n[07:44:24:INFO] Test Case '-[SettingsTestCase testAccessibilityOnBandwidthPreloadWebpagesSettingsPage]' passed (19.471 seconds).\n[07:44:24:INFO] Test Case '-[SettingsTestCase testAccessibilityOnContentSettingsBlockPopupsPage]' started.\n[07:44:44:INFO] Test Case '-[SettingsTestCase testAccessibilityOnContentSettingsBlockPopupsPage]' passed (19.746 seconds).\n[07:44:44:INFO] Test Case '-[SettingsTestCase testAccessibilityOnContentSettingsPage]' started.\n[07:45:00:INFO] Test Case '-[SettingsTestCase testAccessibilityOnContentSettingsPage]' passed (16.593 seconds).\n[07:45:00:INFO] Test Case '-[SettingsTestCase testAccessibilityOnContentSettingsTranslatePage]' started.\n[07:45:20:INFO] Test Case '-[SettingsTestCase testAccessibilityOnContentSettingsTranslatePage]' passed (19.472 seconds).\n[07:45:20:INFO] Test Case '-[SettingsTestCase testAccessibilityOnGoogleChrome]' started.\n[07:45:39:INFO] Test Case '-[SettingsTestCase testAccessibilityOnGoogleChrome]' passed (19.466 seconds).\n[07:45:39:INFO] Test Case '-[SettingsTestCase testAccessibilityOnPaymentMethods]' started.\n[07:45:56:INFO] Test Case '-[SettingsTestCase testAccessibilityOnPaymentMethods]' passed (16.641 seconds).\n[07:45:56:INFO] Test Case '-[SettingsTestCase testAccessibilityOnPrivacyClearBrowsingHistoryPage]' started.\n[07:46:15:INFO] Test Case '-[SettingsTestCase testAccessibilityOnPrivacyClearBrowsingHistoryPage]' passed (19.055 seconds).\n[07:46:15:INFO] Test Case '-[SettingsTestCase testAccessibilityOnPrivacyHandoffSettingsPage]' started.\n[07:46:34:INFO] Test Case '-[SettingsTestCase testAccessibilityOnPrivacyHandoffSettingsPage]' passed (19.406 seconds).\n[07:46:34:INFO] Test Case '-[SettingsTestCase testAccessibilityOnPrivacySettingsPage]' started.\n[07:46:51:INFO] Test Case '-[SettingsTestCase testAccessibilityOnPrivacySettingsPage]' passed (16.665 seconds).\n[07:46:51:INFO] Test Case '-[SettingsTestCase testAccessibilityOnSearchEngine]' started.\n[07:47:00:INFO] [0424/074700.068310:WARNING:large_icon_service_impl.cc(422)] large icon server fetch empty https://t0.gstatic.com/faviconV2?client=chrome&nfrp=2&check_seen=true&size=96&min_size=48&max_size=256&fallback_opts=TYPE,SIZE,URL&url=https://www.google.com/search\n[07:47:08:INFO] Test Case '-[SettingsTestCase testAccessibilityOnSearchEngine]' passed (17.184 seconds).\n[07:47:08:INFO] Test Case '-[SettingsTestCase testAccessibilityOnSendUsageData]' started.\n[07:47:27:INFO] Test Case '-[SettingsTestCase testAccessibilityOnSendUsageData]' passed (18.343 seconds).\n[07:47:27:INFO] Test Case '-[SettingsTestCase testAccessibilityOnSettingsPage]' started.\n[07:47:39:INFO] Test Case '-[SettingsTestCase testAccessibilityOnSettingsPage]' passed (11.981 seconds).\n[07:47:39:INFO] Test Case '-[SettingsTestCase testAccessibilityOnVoiceSearch]' started.\n[07:47:56:INFO] Test Case '-[SettingsTestCase testAccessibilityOnVoiceSearch]' passed (17.287 seconds).\n[07:47:56:INFO] Test Case '-[SettingsTestCase testBreakpadReporting]' started.\n[07:48:00:INFO] Test Case '-[SettingsTestCase testBreakpadReporting]' passed (4.365 seconds).\n[07:48:00:INFO] Test Case '-[SettingsTestCase testBreakpadReportingFirstLaunch]' started.\n[07:48:05:INFO] Test Case '-[SettingsTestCase testBreakpadReportingFirstLaunch]' passed (4.285 seconds).\n[07:48:05:INFO] Test Case '-[SettingsTestCase testClearCookies]' started.\n[07:48:07:INFO] [0424/074807.610290:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico\n[07:48:35:INFO] Test Case '-[SettingsTestCase testClearCookies]' passed (30.432 seconds).\n[07:48:35:INFO] Test Case '-[SettingsTestCase testMetricsReporting]' started.\n[07:48:39:INFO] Test Case '-[SettingsTestCase testMetricsReporting]' passed (4.330 seconds).\n[07:48:39:INFO] Test Case '-[SettingsTestCase testSettingsKeyboardCommands]' started.\n[07:48:55:INFO] Test Case '-[SettingsTestCase testSettingsKeyboardCommands]' passed (15.603 seconds).\n[07:48:55:INFO] Test Case '-[SettingsTestCase testSettingsSignedOutIncognito]' started.\n[07:49:10:INFO] Test Case '-[SettingsTestCase testSettingsSignedOutIncognito]' passed (14.833 seconds).\n[07:49:10:INFO] Test Suite 'SettingsTestCase' passed at 2019-04-24 07:49:10.238.\n[07:49:10:INFO] \t Executed 21 tests, with 0 failures (0 unexpected) in 338.970 (338.994) seconds\n[07:49:10:INFO] Test Suite 'SigninSettingsTestCase' started at 2019-04-24 07:49:10.239\n[07:49:10:INFO] [0424/074910.241208:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[07:49:10:INFO] Test Case '-[SigninSettingsTestCase testAutomaticSigninPromoDismiss]' started.\n[07:49:30:INFO] Test Case '-[SigninSettingsTestCase testAutomaticSigninPromoDismiss]' passed (20.652 seconds).\n[07:49:30:INFO] Test Case '-[SigninSettingsTestCase testDissmissSigninPromo]' started.\n[07:49:45:INFO] Test Case '-[SigninSettingsTestCase testDissmissSigninPromo]' passed (14.893 seconds).\n[07:49:45:INFO] Test Case '-[SigninSettingsTestCase testSignInPromoWithColdStateUsingPrimaryButton]' started.\n[07:50:05:INFO] Test Case '-[SigninSettingsTestCase testSignInPromoWithColdStateUsingPrimaryButton]' passed (19.638 seconds).\n[07:50:05:INFO] Test Case '-[SigninSettingsTestCase testSignInPromoWithWarmStateUsingPrimaryButton]' started.\n[07:50:17:INFO] [0424/075017.102119:WARNING:sync_encryption_handler_impl.cc(1091)] Nigori had empty encryption keybag.\n[07:50:17:INFO] [0424/075017.103895:WARNING:sync_encryption_handler_impl.cc(1091)] Nigori had empty encryption keybag.\n[07:50:17:INFO] [0424/075017.147745:ERROR:account_info_fetcher.cc(75)] OnOAuthError\n[07:50:17:INFO] [0424/075017.147967:WARNING:account_fetcher_service.cc(333)] Failed to get UserInfo for foo1ID\n[07:50:17:INFO] [0424/075017.181615:ERROR:account_tracker.cc(264)] OnOAuthError\n[07:50:17:INFO] [0424/075017.181821:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID\n[07:50:18:INFO] [0424/075018.805692:INFO:profile_sync_service.cc(1734)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now\n[07:50:18:INFO] [0424/075018.958013:WARNING:spdy_session.cc(3326)] Received HEADERS for invalid stream 1\n[07:50:18:INFO] [0424/075018.958514:WARNING:spdy_session.cc(3326)] Received HEADERS for invalid stream 3\n[07:50:18:INFO] [0424/075018.958799:WARNING:spdy_session.cc(3326)] Received HEADERS for invalid stream 5\n[07:50:21:INFO] [0424/075021.574178:INFO:signin_manager.cc(122)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1\n[07:50:21:INFO] [0424/075021.743487:ERROR:gcm_driver_desktop.cc(978)] Unable to delete the InstanceID token: cannot start the GCM Client\n[07:50:21:INFO] [0424/075021.743716:ERROR:gcm_driver_desktop.cc(1062)] Unable to remove the InstanceID data: cannot start the GCM Client\n[07:50:24:INFO] Test Case '-[SigninSettingsTestCase testSignInPromoWithWarmStateUsingPrimaryButton]' passed (19.280 seconds).\n[07:50:24:INFO] Test Case '-[SigninSettingsTestCase testSignInPromoWithWarmStateUsingSecondaryButton]' started.\n[07:50:40:INFO] [0424/075040.187414:ERROR:account_info_fetcher.cc(75)] OnOAuthError\n[07:50:40:INFO] [0424/075040.187572:WARNING:account_fetcher_service.cc(333)] Failed to get UserInfo for foo1ID\n[07:50:40:INFO] [0424/075040.209629:ERROR:account_tracker.cc(264)] OnOAuthError\n[07:50:40:INFO] [0424/075040.209812:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID\n[07:50:41:INFO] [0424/075041.628726:INFO:profile_sync_service.cc(1734)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now\n[07:50:41:INFO] [0424/075041.749946:WARNING:session_sync_bridge.cc(227)] Dropping modification to local session.\n[07:50:44:INFO] [0424/075044.336838:INFO:signin_manager.cc(122)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1\n[07:50:44:INFO] [0424/075044.538202:ERROR:gcm_driver_desktop.cc(978)] Unable to delete the InstanceID token: cannot start the GCM Client\n[07:50:44:INFO] [0424/075044.538415:ERROR:gcm_driver_desktop.cc(1062)] Unable to remove the InstanceID data: cannot start the GCM Client\n[07:50:44:INFO] [0424/075044.897314:WARNING:gaia_auth_fetcher.cc(882)] Could not reach Google Accounts servers: errno -12\n[07:50:47:INFO] Test Case '-[SigninSettingsTestCase testSignInPromoWithWarmStateUsingSecondaryButton]' passed (22.834 seconds).\n[07:50:47:INFO] Test Suite 'SigninSettingsTestCase' passed at 2019-04-24 07:50:47.548.\n[07:50:47:INFO] \t Executed 5 tests, with 0 failures (0 unexpected) in 97.297 (97.309) seconds\n[07:50:47:INFO] Test Suite 'TranslateUITestCase' started at 2019-04-24 07:50:47.549\n[07:50:47:INFO] [0424/075047.549994:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist.\n[07:50:47:INFO] Test Case '-[TranslateUITestCase testAccessibilityOfTranslateSettings]' started.\n[07:51:07:INFO] [0424/075107.640015:WARNING:gaia_auth_fetcher.cc(882)] Could not reach Google Accounts servers: errno -12\n[07:51:10:INFO] Test Case '-[TranslateUITestCase testAccessibilityOfTranslateSettings]' passed (23.262 seconds).\n[07:51:10:INFO] Test Suite 'TranslateUITestCase' passed at 2019-04-24 07:51:10.819.\n[07:51:10:INFO] \t Executed 1 test, with 0 failures (0 unexpected) in 23.262 (23.271) seconds\n[07:51:10:INFO] Test Suite 'ios_chrome_settings_egtests.app' passed at 2019-04-24 07:51:10.821.\n[07:51:10:INFO] \t Executed 84 tests, with 0 failures (0 unexpected) in 1907.763 (1909.821) seconds\n[07:51:10:INFO] Test Suite 'All tests' passed at 2019-04-24 07:51:10.822.\n[07:51:10:INFO] \t Executed 84 tests, with 0 failures (0 unexpected) in 1907.763 (1909.825) seconds\n[07:51:11:INFO] \n[07:51:11:INFO] \n[07:51:11:INFO] Test session results and logs:\n[07:51:11:INFO] \t/Users/chrome-bot/Library/Developer/Xcode/DerivedData/temporary-acsndxmisffmvxhcaifoiwyxtinm/Logs/Test/Test-Transient Testing-2019.04.24_07-18-42--0700.xcresult\n[07:51:11:INFO] \n[07:51:11:INFO] 2019-04-24 07:51:11.297 xcodebuild[44883:1665375] [MT] IDETestOperationsObserverDebug: 1948.930 elapsed -- Testing started completed.\n[07:51:11:INFO] 2019-04-24 07:51:11.297 xcodebuild[44883:1665375] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start\n[07:51:11:INFO] 2019-04-24 07:51:11.297 xcodebuild[44883:1665375] [MT] IDETestOperationsObserverDebug: 1948.930 sec, +1948.930 sec -- end\n[07:51:11:INFO] ** TEST EXECUTE SUCCEEDED **\n[07:51:11:INFO] \n[07:51:15:DEBUG] Finished print_process_output.\n[07:51:15:INFO] Waiting for test process to terminate.\n[07:51:15:INFO] Test process terminated.\n[07:51:15:DEBUG] Setting sigterm handler.\n[07:51:15:DEBUG] Stdout flushed after test process.\n[07:51:15:DEBUG] Processing test results.\n[07:51:15:INFO] /b/s/w/ir/src/out/Debug-iphonesimulator/iossim returned 0\n\n[07:51:15:DEBUG] Extracting test data.\n[07:51:15:DEBUG] Retrieving crash reports.\n[07:51:15:DEBUG] Retrieving derived data.\n[07:51:15:DEBUG] Making desktop screenshots.\n[07:51:16:DEBUG] Killing simulators.\n[07:51:21:DEBUG] Wiping simulator.\nDevice wiped.\n[07:51:24:DEBUG] End of tear_down.\n", "outputs_ref": { "isolated": "c34ed8505fae7c0bb8f8b9dfd8a3a04a567c25c8", "isolatedserver": "https://isolateserver.appspot.com", "namespace": "default-gzip" }, "run_id": "4468876886211511", "server_versions": [ "4267-53b17d5" ], "started_ts": "2019-04-24T14:18:07.919656", "state": "COMPLETED", "tags": [ "build_is_experimental:false", "buildername:ios-slimnav", "buildnumber:150", "data:8c43d4425d433f7f844231cec71ae14f395852bc", "device_type:iPhone X", "gerrit:https://chromium-review.googlesource.com/c/1582182/3", "ios_version:11.4", "master:tryserver.chromium.mac", "name:ios_chrome_settings_egtests", "os:Mac-10.13.6", "platform:simulator", "pool:Chrome", "priority:30", "service_account:ios-isolated-tester@chops-service-accounts.iam.gserviceaccount.com", "slavename:vm1101-m4", "spec_name:chromium.try:ios-slimnav", "stepname:ios_chrome_settings_egtests (iPhone X iOS 11.4) on Mac-10.13.6", "swarming.pool.template:none", "swarming.pool.version:c424873f05276d2f43d63b0aaf7372df443670c4", "test:ios_chrome_settings_egtests", "user:None" ], "task_id": "4468876886211510", "try_number": "1" } ] }