[Wallet USS] Flakiness with the uss metadata bridge: DeleteServerAddressMetadataWhenDataGetsRemoved |
|
Issue descriptionCopying a new type of flakiness occurring in the USS metadata implementation: [ RUN ] USS/TwoClientWalletSyncTest.DeleteServerAddressMetadataWhenDataGetsRemoved/1 [23213:23213:0113/054751.704084:20436065816:WARNING:loopback_server.cc(719)] Loopback sync persistent state file does not exist. [1:1:0113/054752.918449:INFO:hugepage_text.cc(68)] Mlocking text pages failed: Cannot allocate memory (12) [23213:23213:0113/054753.789336:WARNING:chrome_browser_main_chromeos.cc(547)] Running as stub user with profile dir: test-user [23213:23213:0113/054754.397038:INFO:remote_commands_service.cc(38)] Fetching remote commands. [23213:23213:0113/054754.397155:WARNING:remote_commands_service.cc(40)] Client is not registered. [23213:23213:0113/054754.398070:INFO:remote_commands_invalidator.cc(32)] Initialize RemoteCommandsInvalidator. [23213:23213:0113/054754.398175:INFO:remote_commands_invalidator.cc(57)] Starting RemoteCommandsInvalidator. [23213:23213:0113/054754.398275:INFO:remote_commands_invalidator.cc(123)] RemoteCommandsInvalidator ReloadPolicyData. [23213:23213:0113/054754.398370:INFO:remote_commands_invalidator.cc(167)] Unregister RemoteCommandsInvalidator. [23213:23213:0113/054754.624167:WARNING:wallpaper_controller_client.cc(358)] Cannot get wallpaper files id in RemovePolicyWallpaper. This should never happen under normal circumstances. [23213:23213:0113/054755.116085:WARNING:personal_data_manager.cc(492)] 0x38046926ab20 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054755.207852:WARNING:personal_data_manager.cc(492)] 0x38046912bb20 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054755.608042:ERROR:gpu_interface_provider.cc(87)] Not implemented reached in virtual void content::GpuInterfaceProvider::RegisterOzoneGpuInterfaces(service_manager::BinderRegistry *) [23213:23213:0113/054756.737270:INFO:remote_commands_service.cc(38)] Fetching remote commands. [23213:23213:0113/054756.737387:WARNING:remote_commands_service.cc(40)] Client is not registered. [23213:23213:0113/054756.737474:INFO:remote_commands_invalidator.cc(32)] Initialize RemoteCommandsInvalidator. [23213:23213:0113/054756.737528:INFO:remote_commands_invalidator.cc(57)] Starting RemoteCommandsInvalidator. [23213:23213:0113/054756.737583:INFO:remote_commands_invalidator.cc(123)] RemoteCommandsInvalidator ReloadPolicyData. [23213:23213:0113/054756.737633:INFO:remote_commands_invalidator.cc(167)] Unregister RemoteCommandsInvalidator. [23213:23213:0113/054756.764063:WARNING:personal_data_manager.cc(492)] 0x38046b04cde0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054757.273734:INFO:remote_commands_service.cc(38)] Fetching remote commands. [23213:23213:0113/054757.274187:WARNING:remote_commands_service.cc(40)] Client is not registered. [23213:23213:0113/054757.274379:INFO:remote_commands_invalidator.cc(32)] Initialize RemoteCommandsInvalidator. [23213:23213:0113/054757.274514:INFO:remote_commands_invalidator.cc(57)] Starting RemoteCommandsInvalidator. [23213:23213:0113/054757.274621:INFO:remote_commands_invalidator.cc(123)] RemoteCommandsInvalidator ReloadPolicyData. [23213:23213:0113/054757.274736:INFO:remote_commands_invalidator.cc(167)] Unregister RemoteCommandsInvalidator. [23213:23213:0113/054757.289762:WARNING:personal_data_manager.cc(492)] 0x38046aff10a0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054757.626543:INFO:remote_commands_service.cc(38)] Fetching remote commands. [23213:23213:0113/054757.626681:WARNING:remote_commands_service.cc(40)] Client is not registered. [23213:23213:0113/054757.626855:INFO:remote_commands_invalidator.cc(32)] Initialize RemoteCommandsInvalidator. [23213:23213:0113/054757.626972:INFO:remote_commands_invalidator.cc(57)] Starting RemoteCommandsInvalidator. [23213:23213:0113/054757.627093:INFO:remote_commands_invalidator.cc(123)] RemoteCommandsInvalidator ReloadPolicyData. [23213:23213:0113/054757.627248:INFO:remote_commands_invalidator.cc(167)] Unregister RemoteCommandsInvalidator. [23213:23213:0113/054757.653658:WARNING:personal_data_manager.cc(492)] 0x38046babf360 refresh is done, notifying PersonalDataChanged [23213:23396:0113/054757.866581:WARNING:sync_encryption_handler_impl.cc(1080)] Nigori had empty encryption keybag. [23213:23396:0113/054757.871073:WARNING:sync_encryption_handler_impl.cc(1080)] Nigori had empty encryption keybag. [23213:23213:0113/054757.895314:ERROR:chrome_device_id_helper.cc(42)] Device ID is not set for user. [23213:23213:0113/054757.895852:INFO:profile_sync_service.cc(2030)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now [23213:23213:0113/054757.902866:INFO:profile_sync_service.cc(2030)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now [23213:23213:0113/054757.925201:ERROR:account_tracker.cc(263)] OnOAuthError [23213:23213:0113/054757.925256:WARNING:account_tracker.cc(189)] Failed to get UserInfo for user@gmail.com [23213:23256:0113/054757.962122:WARNING:simple_synchronous_entry.cc(1362)] Could not open platform files for entry. [23213:23213:0113/054758.070310:WARNING:personal_data_manager.cc(500)] 0x38046b04cde0 has synced new data, refreshing [23213:23213:0113/054758.071934:WARNING:personal_data_manager.cc(500)] 0x38046b04cde0 has synced new data, refreshing [23213:23213:0113/054758.096943:WARNING:personal_data_manager.cc(492)] 0x38046b04cde0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054758.099572:WARNING:personal_data_manager.cc(2363)] 0x38046b04cde0 converting address CD355624FC2E0E41281EABCD6C8257AB10B00F6E John S. Doe John S. Doe Company-1 1234 Fake Street App 2 DepLoc Cityville Stateful 90011 CEDEX US en 1.800.555.1234 0 1 1 1970-01-01 00:00:25.000 UTC [23213:23213:0113/054758.104111:WARNING:personal_data_manager.cc(2320)] 0x38046b04cde0 conversion of addresses done [23213:23401:0113/054758.204107:WARNING:sync_encryption_handler_impl.cc(1080)] Nigori had empty encryption keybag. [23213:23401:0113/054758.207563:WARNING:sync_encryption_handler_impl.cc(1080)] Nigori had empty encryption keybag. [23213:23253:0113/054758.208155:WARNING:simple_synchronous_entry.cc(1362)] Could not open platform files for entry. [23213:23213:0113/054758.245122:ERROR:chrome_device_id_helper.cc(42)] Device ID is not set for user. [23213:23213:0113/054758.247078:INFO:profile_sync_service.cc(2030)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now [23213:23213:0113/054758.252671:INFO:profile_sync_service.cc(2030)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now [23213:23213:0113/054758.270181:WARNING:personal_data_manager.cc(492)] 0x38046b04cde0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054758.308386:ERROR:account_tracker.cc(263)] OnOAuthError [23213:23213:0113/054758.308454:WARNING:account_tracker.cc(189)] Failed to get UserInfo for user@gmail.com [23213:23213:0113/054758.410658:WARNING:personal_data_manager.cc(500)] 0x38046aff10a0 has synced new data, refreshing [23213:23213:0113/054758.415667:WARNING:personal_data_manager.cc(500)] 0x38046aff10a0 has synced new data, refreshing [23213:23213:0113/054758.439092:WARNING:personal_data_manager.cc(492)] 0x38046aff10a0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054758.441438:WARNING:personal_data_manager.cc(2363)] 0x38046aff10a0 converting address CD355624FC2E0E41281EABCD6C8257AB10B00F6E John S. Doe John S. Doe Company-1 1234 Fake Street App 2 DepLoc Cityville Stateful 90011 CEDEX US en 1.800.555.1234 0 1 1 1970-01-01 00:00:25.000 UTC [23213:23213:0113/054758.443991:WARNING:personal_data_manager.cc(2320)] 0x38046aff10a0 conversion of addresses done [23213:23213:0113/054758.459485:WARNING:personal_data_manager.cc(492)] 0x38046b04cde0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054758.471834:WARNING:personal_data_manager.cc(492)] 0x38046aff10a0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054758.482375:WARNING:personal_data_manager.cc(500)] 0x38046aff10a0 has synced new data, refreshing [23213:23213:0113/054758.514874:WARNING:personal_data_manager.cc(492)] 0x38046aff10a0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054758.530469:WARNING:personal_data_manager.cc(492)] 0x38046b04cde0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054758.547691:WARNING:personal_data_manager.cc(492)] 0x38046b04cde0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054758.549539:WARNING:wallet_helper.cc(110)] A#0 CD355624FC2E0E41281EABCD6C8257AB10B00F6E John S. Doe John S. Doe Company-1 1234 Fake Street App 2 DepLoc Cityville Stateful 90011 CEDEX US en 1.800.555.1234 0 1 2 1970-01-01 01:23:20.000 UTC [23213:23213:0113/054758.549619:WARNING:wallet_helper.cc(114)] B#0 CD355624FC2E0E41281EABCD6C8257AB10B00F6E John S. Doe John S. Doe Company-1 1234 Fake Street App 2 DepLoc Cityville Stateful 90011 CEDEX US en 1.800.555.1234 0 1 1 1970-01-01 00:00:25.000 UTC [23213:23213:0113/054758.562759:WARNING:personal_data_manager.cc(492)] 0x38046aff10a0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054758.564638:WARNING:wallet_helper.cc(110)] A#0 CD355624FC2E0E41281EABCD6C8257AB10B00F6E John S. Doe John S. Doe Company-1 1234 Fake Street App 2 DepLoc Cityville Stateful 90011 CEDEX US en 1.800.555.1234 0 1 2 1970-01-01 01:23:20.000 UTC [23213:23213:0113/054758.564737:WARNING:wallet_helper.cc(114)] B#0 CD355624FC2E0E41281EABCD6C8257AB10B00F6E John S. Doe John S. Doe Company-1 1234 Fake Street App 2 DepLoc Cityville Stateful 90011 CEDEX US en 1.800.555.1234 0 1 1 1970-01-01 00:00:25.000 UTC [23213:23213:0113/054758.565290:WARNING:wallet_helper.cc(110)] A#0 CD355624FC2E0E41281EABCD6C8257AB10B00F6E John S. Doe John S. Doe Company-1 1234 Fake Street App 2 DepLoc Cityville Stateful 90011 CEDEX US en 1.800.555.1234 0 1 2 1970-01-01 01:23:20.000 UTC [23213:23213:0113/054758.565364:WARNING:wallet_helper.cc(114)] B#0 CD355624FC2E0E41281EABCD6C8257AB10B00F6E John S. Doe John S. Doe Company-1 1234 Fake Street App 2 DepLoc Cityville Stateful 90011 CEDEX US en 1.800.555.1234 0 1 1 1970-01-01 00:00:25.000 UTC [23213:23213:0113/054758.609131:WARNING:personal_data_manager.cc(500)] 0x38046aff10a0 has synced new data, refreshing [23213:23213:0113/054758.610191:WARNING:personal_data_manager.cc(500)] 0x38046aff10a0 has synced new data, refreshing [23213:23213:0113/054758.617527:WARNING:personal_data_manager.cc(492)] 0x38046aff10a0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054758.619895:WARNING:wallet_helper.cc(110)] A#0 CD355624FC2E0E41281EABCD6C8257AB10B00F6E John S. Doe John S. Doe Company-1 1234 Fake Street App 2 DepLoc Cityville Stateful 90011 CEDEX US en 1.800.555.1234 0 1 2 1970-01-01 01:23:20.000 UTC [23213:23213:0113/054758.623026:WARNING:personal_data_manager.cc(500)] 0x38046b04cde0 has synced new data, refreshing [23213:23213:0113/054758.639857:WARNING:personal_data_manager.cc(492)] 0x38046b04cde0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054758.642215:WARNING:wallet_helper.cc(110)] A#0 CD355624FC2E0E41281EABCD6C8257AB10B00F6E John S. Doe John S. Doe Company-1 1234 Fake Street App 2 DepLoc Cityville Stateful 90011 CEDEX US en 1.800.555.1234 0 1 2 1970-01-01 01:23:20.000 UTC [23213:23213:0113/054758.649431:WARNING:personal_data_manager.cc(500)] 0x38046b04cde0 has synced new data, refreshing [23213:23213:0113/054758.663777:WARNING:personal_data_manager.cc(492)] 0x38046b04cde0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054758.676005:WARNING:personal_data_manager.cc(492)] 0x38046b04cde0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054758.683409:WARNING:personal_data_manager.cc(492)] 0x38046aff10a0 refresh is done, notifying PersonalDataChanged ../../chrome/browser/sync/test/integration/two_client_wallet_sync_test.cc:689: Failure Expected equality of these values: 0U Which is: 0 addresses_metadata_1.size() Which is: 1 Stack trace: #0 0x55a649e061f0 StackTraceGetter::CurrentStackTrace() #1 0x55a649e155f7 testing::internal::UnitTestImpl::CurrentOsStackTraceExceptTop() #2 0x55a649e15183 testing::internal::AssertHelper::operator=() #3 0x55a649dea36c (anonymous namespace)::TwoClientWalletSyncTest_DeleteServerAddressMetadataWhenDataGetsRemoved_Test::RunTestOnMainThread() #4 0x55a650bef174 content::BrowserTestBase::ProxyRunTestOnMainThreadLoop() #5 0x55a649f3097d base::internal::FunctorTraits<>::Invoke<>() #6 0x55a649f308c1 base::internal::InvokeHelper<>::MakeItSo<>() #7 0x55a650bf1797 _ZN4base8internal7InvokerINS0_9BindStateIMN7content15BrowserTestBaseEFvvEJNS0_17UnretainedWrapperIS4_EEEEEFvvEE7RunImplIRKS6_RKNSt4__Cr5tupleIJS8_EEEJLm0EEEEvOT_OT0_NSF_16integer_sequenceImJXspT1_EEEE #8 0x55a650bf16cc base::internal::Invoker<>::Run() #9 0x55a649c8f52d _ZNKR4base17RepeatingCallbackIFvvEE3RunEv #10 0x55a64d279aaf ChromeBrowserMainParts::PreMainMessageLoopRunImpl() #11 0x55a64d27885e ChromeBrowserMainParts::PreMainMessageLoopRun() #12 0x55a64bc24944 chromeos::ChromeBrowserMainPartsChromeos::PreMainMessageLoopRun() #13 0x7f015dc53857 content::BrowserMainLoop::PreMainMessageLoopRun() #14 0x7f015cde33ad base::internal::FunctorTraits<>::Invoke<>() #15 0x7f015cde32f1 base::internal::InvokeHelper<>::MakeItSo<>() #16 0x7f015dc59d17 _ZN4base8internal7InvokerINS0_9BindStateIMN7content15BrowserMainLoopEFivEJNS0_17UnretainedWrapperIS4_EEEEEFivEE7RunImplIRKS6_RKNSt4__Cr5tupleIJS8_EEEJLm0EEEEiOT_OT0_NSF_16integer_sequenceImJXspT1_EEEE #17 0x7f015dc59c4c base::internal::Invoker<>::Run() #18 0x7f015cd3b0ad _ZNKR4base17RepeatingCallbackIFvvEE3RunEv #19 0x7f015e7c851c content::StartupTaskRunner::RunAllTasksNow() #20 0x7f015dc52085 content::BrowserMainLoop::CreateStartupTasks() #21 0x7f015dc5c10e content::BrowserMainRunnerImpl::Initialize() #22 0x7f015dc4f2c9 content::BrowserMain() #23 0x7f015f69c6fb content::RunBrowserProcessMain() #24 0x7f015f69d9b6 content::ContentMainRunnerImpl::RunServiceManager() #25 0x7f015f69d470 content::ContentMainRunnerImpl::Run() #26 0x7f015f69aa39 content::ContentServiceManagerMainDelegate::RunEmbedderProcess() #27 0x7f0136c36bf3 service_manager::Main() #28 0x7f015f69c205 content::ContentMain() #29 0x55a650beec89 content::BrowserTestBase::SetUp() #30 0x55a64d07744e InProcessBrowserTest::SetUp() #31 0x55a64d04d573 SyncTest::SetUp() #32 0x55a649e331ee testing::internal::HandleSehExceptionsInMethodIfSupported<>() [23213:23213:0113/054759.208898:WARNING:personal_data_manager.cc(492)] 0x38046b04cde0 refresh is done, notifying PersonalDataChanged [23213:23269:0113/054759.279432:WARNING:client_tag_based_model_type_processor.cc(762)] Received remote delete for a non-existing item. client_tag_hash: ZVQtiCqdDIypBBTy17nx7fkt0DI= [23213:23213:0113/054759.306063:WARNING:personal_data_manager.cc(492)] 0x38046aff10a0 refresh is done, notifying PersonalDataChanged [23213:23213:0113/054800.099826:INFO:remote_commands_invalidator.cc(45)] Shutdown RemoteCommandsInvalidator. [23213:23213:0113/054800.099969:INFO:remote_commands_invalidator.cc(68)] Stopping RemoteCommandsInvalidator. [23213:23213:0113/054800.100094:INFO:remote_commands_invalidator.cc(167)] Unregister RemoteCommandsInvalidator. [23213:23213:0113/054800.198595:ERROR:http_bridge.cc(126)] Not implemented reached in virtual void syncer::HttpBridgeFactory::OnSignalReceived() [23213:23213:0113/054800.210168:INFO:remote_commands_invalidator.cc(45)] Shutdown RemoteCommandsInvalidator. [23213:23213:0113/054800.210337:INFO:remote_commands_invalidator.cc(68)] Stopping RemoteCommandsInvalidator. [23213:23213:0113/054800.210436:INFO:remote_commands_invalidator.cc(167)] Unregister RemoteCommandsInvalidator. [23213:23213:0113/054800.315077:INFO:remote_commands_invalidator.cc(45)] Shutdown RemoteCommandsInvalidator. [23213:23213:0113/054800.315227:INFO:remote_commands_invalidator.cc(68)] Stopping RemoteCommandsInvalidator. [23213:23213:0113/054800.315341:INFO:remote_commands_invalidator.cc(167)] Unregister RemoteCommandsInvalidator. [23213:23213:0113/054800.404937:INFO:remote_commands_invalidator.cc(45)] Shutdown RemoteCommandsInvalidator. [23213:23213:0113/054800.405169:INFO:remote_commands_invalidator.cc(68)] Stopping RemoteCommandsInvalidator. [23213:23213:0113/054800.405285:INFO:remote_commands_invalidator.cc(167)] Unregister RemoteCommandsInvalidator. [23213:23247:0113/054800.634395:WARNING:discardable_shared_memory_manager.cc(410)] Some MojoDiscardableSharedMemoryManagerImpls are still alive. They will be leaked. [23213:23527:0113/054800.637024:WARNING:internal_linux.cc(64)] Failed to read /proc/23262/stat [23213:23213:0113/054800.663221:WARNING:pref_notifier_impl.cc(23)] Pref observer found at shutdown. [23213:23213:0113/054800.663318:WARNING:pref_notifier_impl.cc(23)] Pref observer found at shutdown. [ FAILED ] USS/TwoClientWalletSyncTest.DeleteServerAddressMetadataWhenDataGetsRemoved/1, where GetParam() = true (8981 ms)
,
Jan 17
(5 days ago)
The following revision refers to this bug: https://chromium.googlesource.com/chromium/src.git/+/4650212f165ebf085dd2c17513e809ea5d4eb7eb commit 4650212f165ebf085dd2c17513e809ea5d4eb7eb Author: Jan Krcal <jkrcal@chromium.org> Date: Thu Jan 17 15:03:19 2019 [AF Wallet Sync] Fix raciness causing the clients not to converge This CL fixes another cause of flakiness in TwoClientWalletSyncTest.DeleteServer*MetadataWhenDataGetsRemoved. It turned out the tests was set up inherently racy: 1) one machine updated metadata entry A and uploaded it to sync, 2) both machines deleted entry A and uploaded deletion to sync. If the update from 1) got to the other machine before it started deleting A in 2) all worked fine. In the other case, the machines ended up in an inconsistent state where one had A and the other not. Bug: 921386 Change-Id: I958d402fa9c79ef41a5a32e8300e18a1263c6cab Reviewed-on: https://chromium-review.googlesource.com/c/1414935 Commit-Queue: Sebastien Seguin-Gagnon <sebsg@chromium.org> Reviewed-by: Sebastien Seguin-Gagnon <sebsg@chromium.org> Cr-Commit-Position: refs/heads/master@{#623685} [modify] https://crrev.com/4650212f165ebf085dd2c17513e809ea5d4eb7eb/chrome/browser/sync/test/integration/two_client_wallet_sync_test.cc |
|
►
Sign in to add a comment |
|
Comment 1 by bugdroid1@chromium.org
, Jan 15