Test crashed (return code: 100)
==1054801==ERROR: LeakSanitizer: detected memory leaks
Direct leak of 224 byte(s) in 1 object(s) allocated from:
    #0 0x19201a0d in operator new(unsigned long) /-S/contrib/libs/clang18-rt/lib/asan/asan_new_delete.cpp:86:3
    #1 0x2b212320 in make_unique<NKikimr::NEvents::TDataEvents::TEvWriteResult> /-S/contrib/libs/cxxsupp/libcxx/include/__memory/unique_ptr.h:621:26
    #2 0x2b212320 in NKikimr::NEvents::TDataEvents::TEvWriteResult::BuildCompleted(unsigned long, unsigned long) /-S/ydb/core/tx/data_events/events.h:123:27
    #3 0x2b20b8d6 in NKikimr::NDataShard::TExecuteWriteUnit::Execute(TIntrusivePtr<NKikimr::NDataShard::TOperation, TDefaultIntrusivePtrOps<NKikimr::NDataShard::TOperation>>, NKikimr::NTabletFlatExecutor::TTransactionContext&, NActors::TActorContext const&) /-S/ydb/core/tx/datashard/execute_write_unit.cpp:376:37
    #4 0x2b0647cc in NKikimr::NDataShard::TPipeline::RunExecutionPlan(TIntrusivePtr<NKikimr::NDataShard::TOperation, TDefaultIntrusivePtrOps<NKikimr::NDataShard::TOperation>>, TVector<NKikimr::NDataShard::EExecutionUnitKind, std::__y1::allocator<NKikimr::NDataShard::EExecutionUnitKind>>&, NKikimr::NTabletFlatExecutor::TTransactionContext&, NActors::TActorContext const&) /-S/ydb/core/tx/datashard/datashard_pipeline.cpp:1851:28
    #5 0x2ad25614 in NKikimr::NDataShard::TDataShard::TTxWrite::Execute(NKikimr::NTabletFlatExecutor::TTransactionContext&, NActors::TActorContext const&) /-S/ydb/core/tx/datashard/datashard__write.cpp:100:38
    #6 0x20812894 in NKikimr::NTabletFlatExecutor::TExecutor::ExecuteTransaction(NKikimr::NTabletFlatExecutor::TSeat*) /-S/ydb/core/tablet_flat/flat_executor.cpp:1910:35
    #7 0x2080e234 in NKikimr::NTabletFlatExecutor::TExecutor::DoExecute(TAutoPtr<NKikimr::NTabletFlatExecutor::ITransaction, TDelete>, NKikimr::NTabletFlatExecutor::TExecutor::ETxMode) /-S/ydb/core/tablet_flat/flat_executor.cpp:1814:13
    #8 0x2081542e in NKikimr::NTabletFlatExecutor::TExecutor::Execute(TAutoPtr<NKikimr::NTabletFlatExecutor::ITransaction, TDelete>, NActors::TActorContext const&) /-S/ydb/core/tablet_flat/flat_executor.cpp:1828:5
    #9 0x207aba9a in Execute /-S/ydb/core/tablet_flat/tablet_flat_executed.cpp:62:46
    #10 0x207aba9a in NKikimr::NTabletFlatExecutor::TTabletExecutedFlat::Execute(TAutoPtr<NKikimr::NTabletFlatExecutor::ITransaction, TDelete>, NActors::TActorContext const&) /-S/ydb/core/tablet_flat/tablet_flat_executed.cpp:57:5
    #11 0x21e3c271 in NKikimr::NDataShard::TDataShard::Handle(TAutoPtr<NActors::TEventHandle<NKikimr::NDataShard::TDataShard::TEvPrivate::TEvDelayedProposeTransaction>, TDelete>&, NActors::TActorContext const&) /-S/ydb/core/tx/datashard/datashard.cpp:3415:21
    #12 0x21de4c5b in NKikimr::NDataShard::TDataShard::StateWork(TAutoPtr<NActors::IEventHandle, TDelete>&) /-S/ydb/core/tx/datashard/datashard_impl.h:3157:13
    #13 0x1a71042c in NActors::IActor::Receive(TAutoPtr<NActors::IEventHandle, TDelete>&) /-S/ydb/library/actors/core/actor.cpp:280:13
    #14 0x36e9f094 in NActors::TTestActorRuntimeBase::SendInternal(TAutoPtr<NActors::IEventHandle, TDelete>, unsigned int, bool) /-S/ydb/library/actors/testlib/test_runtime.cpp:1702:33
    #15 0x36e97909 in NActors::TTestActorRuntimeBase::DispatchEventsInternal(NActors::TDispatchOptions const&, TInstant) /-S/ydb/library/actors/testlib/test_runtime.cpp:1295:45
    #16 0x36ea1c83 in NActors::TTestActorRuntimeBase::WaitForEdgeEvents(std::__y1::function<bool (NActors::TTestActorRuntimeBase&, TAutoPtr<NActors::IEventHandle, TDelete>&)>, TSet<NActors::TActorId, TLess<NActors::TActorId>, std::__y1::allocator<NActors::TActorId>> const&, TDuration) /-S/ydb/library/actors/testlib/test_runtime.cpp:1554:22
    #17 0x3706a343 in NActors::TEvents::TEvWakeup::TPtr NActors::TTestActorRuntimeBase::GrabEdgeEventIf<NActors::TEvents::TEvWakeup>(TSet<NActors::TActorId, TLess<NActors::TActorId>, std::__y1::allocator<NActors::TActorId>> const&, std::__y1::function<bool (NActors::TEvents::TEvWakeup::TPtr const&)> const&, TDuration) /-S/ydb/library/actors/testlib/test_runtime.h:477:13
    #18 0x370698e2 in GrabEdgeEvent<NActors::TEvents::TEvWakeup> /-S/ydb/library/actors/testlib/test_runtime.h:526:20
    #19 0x370698e2 in NActors::TEvents::TEvWakeup::TPtr NActors::TTestActorRuntimeBase::GrabEdgeEvent<NActors::TEvents::TEvWakeup>(NActors::TActorId const&, TDuration) /-S/ydb/library/actors/testlib/test_runtime.h:532:20
    #20 0x37061b42 in NActors::TEvents::TEvWakeup::TPtr NActors::TTestActorRuntimeBase::GrabEdgeEventRethrow<NActors::TEvents::TEvWakeup>(NActors::TActorId const&, TDuration) /-S/ydb/library/actors/testlib/test_runtime.h:577:24
    #21 0x3706171a in NActors::TTestActorRuntime::SimulateSleep(TDuration) /-S/ydb/core/testlib/actors/test_runtime.cpp:298:9
    #22 0x18f95247 in NKikimr::NTestSuiteDataShardVolatile::TTestCaseGracefulShardRestartNoEarlyReadSetAck::Execute_(NUnitTest::TTestContext&) /-S/ydb/core/tx/datashard/datashard_ut_volatile.cpp:3909:17
    #23 0x18faab07 in operator() /-S/ydb/core/tx/datashard/datashard_ut_volatile.cpp:17:1
    #24 0x18faab07 in __invoke<(lambda at /-S/ydb/core/tx/datashard/datashard_ut_volatile.cpp:17:1) &> /-S/contrib/libs/cxxsupp/libcxx/include/__type_traits/invoke.h:150:25
    #25 0x18faab07 in __call<(lambda at /-S/ydb/core/tx/datashard/datashard_ut_volatile.cpp:17:1) &> /-S/contrib/libs/cxxsupp/libcxx/include/__type_traits/invoke.h:225:5
    #26 0x18faab07 in operator() /-S/contrib/libs/cxxsupp/libcxx/include/__functional/function.h:171:12
    #27 0x18faab07 in std::__y1::__function::__func<NKikimr::NTestSuiteDataShardVolatile::TCurrentTest::Execute()::'lambda'(), std::__y1::allocator<NKikimr::NTestSuiteDataShardVolatile::TCurrentTest::Execute()::'lambda'()>, void ()>::operator()() /-S/contrib/libs/cxxsupp/libcxx/include/__functional/function.h:313:10
    #28 0x199c1c35 in operator() /-S/contrib/libs/cxxsupp/libcxx/include/__functional/function.h:430:12
    #29 0x199c1c35 in operator() /-S/contrib/libs/cxxsupp/libcxx/include/__functional/function.h:989:10
    #30 0x199c1c35 in TColoredProcessor::Run(std::__y1::function<void ()>, TBasicString<char, std::__y1::char_traits<char>> const&, char const*, bool) /-S/library/cpp/testing/unittest/utmain.cpp:525:20
    #31 0x19991788 in NUnitTest::TTestBase::Run(std::__y1::function<void ()>, TBasicString<char, std::__y1::char_traits<char>> const&, char const*, bool) /-S/library/cpp/testing/unittest/registar.cpp:374:18
    #32 0x18fa99b3 in NKikimr::NTestSuiteDataShardVolatile::TCurrentTest::Execute() /-S/ydb/core/tx/datashard/datashard_ut_volatile.cpp:17:1
    #33 0x19993055 in NUnitTest::TTestFactory::Execute() /-S/library/cpp/testing/unittest/registar.cpp:495:19
    #34 0x199bc1ac in NUnitTest::RunMain(int, char**) /-S/library/cpp/testing/unittest/utmain.cpp:872:44
    #35 0x7f2d05a6bd8f  (/lib/x86_64-linux-gnu/libc.so.6+0x29d8f) (BuildId: 490fef8403240c91833978d494d39e537409b92e)
SUMMARY: AddressSanitizer: 664 byte(s) leaked in 11 allocation(s).

logsdir:
/home/runner/actions_runner/_work/ydb/ydb/tmp/out/ydb/core/tx/datashard/ut_volatile/test-results/unittest/testing_out_stuff
stderr:
/home/runner/actions_runner/_work/ydb/ydb/tmp/out/ydb/core/tx/datashard/ut_volatile/test-results/unittest/testing_out_stuff/DataShardVolatile.GracefulShardRestartNoEarlyReadSetAck.err
stdout:
/home/runner/actions_runner/_work/ydb/ydb/tmp/out/ydb/core/tx/datashard/ut_volatile/test-results/unittest/testing_out_stuff/DataShardVolatile.GracefulShardRestartNoEarlyReadSetAck.out

Test crashed (return code: 100)
==1051183==ERROR: AddressSanitizer: heap-use-after-free on address 0x5030050b3f39 at pc 0x000018ee3552 bp 0x7fff675a0010 sp 0x7fff6759f7d0
READ of size 9 at 0x5030050b3f39 thread T0
2025-04-09T22:03:49.743446Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:49.743631Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:49.743719Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:49.743807Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:49.743915Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:49.743952Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:49.744000Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:49.844821Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:49.844984Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:49.845032Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:49.845158Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:49.845336Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:49.845430Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:49.845504Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:49.959680Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:49.959753Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:49.959774Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:49.959814Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:49.959870Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:49.959887Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:49.959908Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:50.064659Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:50.064732Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.064748Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.064791Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:50.064848Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:50.064866Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:50.064891Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:50.173630Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:50.173706Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.173724Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.173767Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:50.173840Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:50.173855Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:50.173876Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:50.274827Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:50.274918Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.274939Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.274977Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:50.275048Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:50.275063Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:50.275089Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:50.380723Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:50.380810Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.380832Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.380878Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:50.380957Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:50.380973Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:50.381000Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:50.436850Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] TPersQueueReadBalancer::HandleWakeup
2025-04-09T22:03:50.436916Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] Send TEvPersQueue::TEvStatus TabletId: 72075186224037892 Cookie: 4
2025-04-09T22:03:50.437295Z node 1 :PERSQUEUE TRACE: HandleHook, received event# 271187975, Sender [1:7491437549015654420:2454], Recipient [1:7491437549015654441:2455]: NKikimrPQ.TStatus GetStatForAllConsumers: true
2025-04-09T22:03:50.437316Z node 1 :PERSQUEUE TRACE: HandleHook, processing event TEvPersQueue::TEvStatus
2025-04-09T22:03:50.437331Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892] Handle TEvPersQueue::TEvStatus
2025-04-09T22:03:50.437423Z node 1 :PERSQUEUE TRACE: HandleHook, received event# 271188536, Sender [1:7491437549015654420:2454], Recipient [1:7491437549015654441:2455]: NKikimrPQ.TEvSubDomainStatus SubDomainOutOfSpace: false
2025-04-09T22:03:50.437437Z node 1 :PERSQUEUE TRACE: HandleHook, processing event TEvPQ::TEvSubDomainStatus
2025-04-09T22:03:50.437525Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188491 (NKikimr::TEvPQ::TEvPartitionStatus), Tablet [1:7491437549015654441:2455], Partition 0, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:50.437564Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188491, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvPartitionStatus
2025-04-09T22:03:50.437581Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvPartitionStatus
2025-04-09T22:03:50.437754Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Topic PartitionStatus PartitionSize: 0 UsedReserveSize: 0 ReserveSize: 0 PartitionConfig{ MaxCountInPartition: 2147483647 LifetimeSeconds: 86400 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 1048576 BurstSize: 1048576 TotalPartitions: 1 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 }
2025-04-09T22:03:50.437851Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188536 (NKikimr::TEvPQ::TEvSubDomainStatus), Tablet [1:7491437549015654441:2455], Partition 0, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:50.437885Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188536, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458]: NKikimrPQ.TEvSubDomainStatus SubDomainOutOfSpace: false
2025-04-09T22:03:50.437897Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvSubDomainStatus
2025-04-09T22:03:50.437937Z node 1 :PERSQUEUE TRACE: HandleHook, received event# 271188503, Sender [1:7491437549015654486:2458], Recipient [1:7491437549015654441:2455]: NKikimr::TEvPQ::TEvPartitionLabeledCounters
2025-04-09T22:03:50.437951Z node 1 :PERSQUEUE TRACE: HandleHook, processing event TEvPQ::TEvPartitionLabeledCounters
2025-04-09T22:03:50.438331Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] Send TEvPeriodicTopicStats PathId: 13 Generation: 1 StatsReportRound: 4 DataSize: 0 UsedReserveSize: 0
2025-04-09T22:03:50.438430Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] ProcessPendingStats. PendingUpdates size 1
2025-04-09T22:03:50.438665Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271188001, Sender [1:7491437549015654420:2454], Recipient [1:7491437514655915003:2189]: NKikimrPQ.TEvPeriodicTopicStats PathId: 13 Generation: 1 Round: 4 DataSize: 0 UsedReserveSize: 0 SubDomainOutOfSpace: false
2025-04-09T22:03:50.438687Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPersQueue::TEvPeriodicTopicStats
2025-04-09T22:03:50.438707Z node 1 :FLAT_TX_SCHEMESHARD INFO: Got periodic topic stats at partition [OwnerId: 72057594046644480, LocalPathId: 13] DataSize 0 UsedReserveSize 0
2025-04-09T22:03:50.438739Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTopicStats on# 0.099990s, queue# 1
2025-04-09T22:03:50.445041Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122945, Sender [1:7491437549015654420:2454], Recipient [1:7491437514655915003:2189]: NKikimrSchemeOp.TDescribePath PathId: 13 SchemeshardId: 72057594046644480
2025-04-09T22:03:50.445086Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvDescribeScheme
2025-04-09T22:03:50.486343Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-04-09T22:03:50.486382Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-04-09T22:03:50.486449Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [1:7491437514655915003:2189], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-04-09T22:03:50.486464Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-04-09T22:03:50.489554Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:50.489628Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.489650Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.489688Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:50.489758Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:50.489777Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:50.489800Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:50.538451Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435095, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:50.538496Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:50.538513Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: Started TEvPersistStats at tablet 72057594046644480, queue size# 1
2025-04-09T22:03:50.538522Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 1
2025-04-09T22:03:50.538581Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTopicStats on# 0.000147s, queue# 1
2025-04-09T22:03:50.539549Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435095, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:50.539577Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:50.539590Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-04-09T22:03:50.564733Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188544 (NKikimr::NPQ::NReadQuoterEvents::TEvQuotaCountersUpdated), Tablet [1:7491437549015654441:2455], Partition 0, Sender [1:7491437549015654490:2460], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:50.564813Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188544, Sender [1:7491437549015654490:2460], Recipient [1:7491437549015654486:2458]: NKikimr::NPQ::NReadQuoterEvents::TEvQuotaCountersUpdated
2025-04-09T22:03:50.564833Z node 1 :PERSQUEUE TRACE: StateIdle, processing event NReadQuoterEvents::TEvQuotaCountersUpdated
2025-04-09T22:03:50.592671Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:50.592746Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.592764Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.592802Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:50.592873Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:50.592893Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:50.592916Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:50.678869Z node 1 :PQ_PARTITION_CHOOSER TRACE: StateInitTable, received event# 278396931, Sender [1:7491437561900557260:2699], Recipient [1:7491437561900557262:2699]: NKikimr::NPQ::TEvPartitionChooser::TEvRefreshRequest
2025-04-09T22:03:50.691135Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:50.691219Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.691243Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.691285Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:50.691358Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:50.691375Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:50.691401Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:50.792403Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:50.792472Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.792493Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.792551Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:50.792617Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:50.792633Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:50.792661Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:50.893439Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:50.893517Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.893540Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.893582Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:50.893654Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:50.893670Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:50.893711Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:50.950055Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [1:7491437566195524663:3296], Recipient [1:7491437514655915003:2189]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-04-09T22:03:50.950100Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-04-09T22:03:50.950118Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-04-09T22:03:50.950539Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [1:7491437523245850137:2354], Recipient [1:7491437514655915003:2189]: NKikimrTxDataShard.TEvPeriodicTableStats DatashardId: 72075186224037889 TableLocalId: 10 Generation: 1 Round: 0 TableStats { DataSize: 824 RowCount: 2 IndexSize: 0 InMemSize: 824 LastAccessTime: 1744236230416 LastUpdateTime: 1744236221216 ImmediateTxCompleted: 0 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 2 RowDeletes: 0 RowReads: 0 RangeReads: 7 PartCount: 0 RangeReadRows: 14 SearchHeight: 1 LastFullCompactionTs: 0 HasLoanedParts: false ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0 } TabletMetrics { Memory: 82488 } ShardState: 2 UserTablePartOwners: 72075186224037889 NodeId: 1 StartTime: 1744236220935 TableOwnerId: 72057594046644480 FollowerId: 0
2025-04-09T22:03:50.950561Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-04-09T22:03:50.950602Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037889 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 10] state 'Ready' dataSize 824 rowCount 2 cpuUsage 0
2025-04-09T22:03:50.950694Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037889 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 10] raw table stats:
DataSize: 824 RowCount: 2 IndexSize: 0 InMemSize: 824 LastAccessTime: 1744236230416 LastUpdateTime: 1744236221216 ImmediateTxCompleted: 0 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 2 RowDeletes: 0 RowReads: 0 RangeReads: 7 PartCount: 0 RangeReadRows: 14 SearchHeight: 1 LastFullCompactionTs: 0 HasLoanedParts: false ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0
2025-04-09T22:03:50.950718Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.099993s, queue# 1
2025-04-09T22:03:50.990975Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [1:7491437566195524667:3299], Recipient [1:7491437514655915003:2189]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-04-09T22:03:50.991014Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-04-09T22:03:50.991028Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-04-09T22:03:50.991380Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [1:7491437523245850198:2360], Recipient [1:7491437514655915003:2189]: NKikimrTxDataShard.TEvPeriodicTableStats DatashardId: 72075186224037890 TableLocalId: 11 Generation: 1 Round: 0 TableStats { DataSize: 0 RowCount: 0 IndexSize: 0 InMemSize: 0 LastAccessTime: 0 LastUpdateTime: 0 ImmediateTxCompleted: 0 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 0 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 0 RangeReadRows: 0 SearchHeight: 0 LastFullCompactionTs: 0 HasLoanedParts: false ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0 } TabletMetrics { Memory: 82488 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 1 StartTime: 1744236220970 TableOwnerId: 72057594046644480 FollowerId: 0
2025-04-09T22:03:50.991404Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-04-09T22:03:50.991434Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 11] state 'Ready' dataSize 0 rowCount 0 cpuUsage 0
2025-04-09T22:03:50.991529Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 11] raw table stats:
DataSize: 0 RowCount: 0 IndexSize: 0 InMemSize: 0 LastAccessTime: 0 LastUpdateTime: 0 ImmediateTxCompleted: 0 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 0 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 0 RangeReadRows: 0 SearchHeight: 0 LastFullCompactionTs: 0 HasLoanedParts: false ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0
2025-04-09T22:03:50.994089Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:50.994157Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.994179Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:50.994219Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:50.994293Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:50.994320Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:50.994346Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:51.051609Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435092, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-04-09T22:03:51.051663Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-04-09T22:03:51.051680Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: Started TEvPersistStats at tablet 72057594046644480, queue size# 2
2025-04-09T22:03:51.051741Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 2
2025-04-09T22:03:51.051762Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.000000s, queue# 2
2025-04-09T22:03:51.051820Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: PersistSingleStats for pathId 10 shard idx 72057594046644480:2 data size 824 row count 2
2025-04-09T22:03:51.051887Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: TTxStoreTableStats.PersistSingleStats: main stats from datashardId(TabletID)=72075186224037889 maps to shardIdx: 72057594046644480:2 followerId=0, pathId: [OwnerId: 72057594046644480, LocalPathId: 10], pathId map=Cluster, is column=0, is olap=0, RowCount 2, DataSize 824
2025-04-09T22:03:51.051898Z node 1 :FLAT_TX_SCHEMESHARD TRACE: BuildStatsForCollector: datashardId 72075186224037889, followerId 0
2025-04-09T22:03:51.051958Z node 1 :FLAT_TX_SCHEMESHARD TRACE: [BackgroundCompaction] [Update] Skipped shard# 72057594046644480:2 with partCount# 0, rowCount# 2, searchHeight# 1, lastFullCompaction# 1970-01-01T00:00:00.000000Z at schemeshard 72057594046644480
2025-04-09T22:03:51.052027Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: PersistSingleStats for pathId 11 shard idx 72057594046644480:3 data size 0 row count 0
2025-04-09T22:03:51.052073Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: TTxStoreTableStats.PersistSingleStats: main stats from datashardId(TabletID)=72075186224037890 maps to shardIdx: 72057594046644480:3 followerId=0, pathId: [OwnerId: 72057594046644480, LocalPathId: 11], pathId map=Topics, is column=0, is olap=0, RowCount 0, DataSize 0
2025-04-09T22:03:51.052083Z node 1 :FLAT_TX_SCHEMESHARD TRACE: BuildStatsForCollector: datashardId 72075186224037890, followerId 0
2025-04-09T22:03:51.052121Z node 1 :FLAT_TX_SCHEMESHARD TRACE: [BackgroundCompaction] [Update] Skipped shard# 72057594046644480:3 with partCount# 0, rowCount# 0, searchHeight# 0, lastFullCompaction# 1970-01-01T00:00:00.000000Z at schemeshard 72057594046644480
2025-04-09T22:03:51.052187Z node 1 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-04-09T22:03:51.053574Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435092, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-04-09T22:03:51.053603Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-04-09T22:03:51.053622Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-04-09T22:03:51.061231Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [1:7491437570490491965:3300], Recipient [1:7491437514655915003:2189]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-04-09T22:03:51.061274Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-04-09T22:03:51.061293Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-04-09T22:03:51.061662Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [1:7491437527540817580:2374], Recipient [1:7491437514655915003:2189]: NKikimrTxDataShard.TEvPeriodicTableStats DatashardId: 72075186224037891 TableLocalId: 12 Generation: 1 Round: 0 TableStats { DataSize: 656 RowCount: 2 IndexSize: 0 InMemSize: 656 LastAccessTime: 1744236230415 LastUpdateTime: 1744236221216 ImmediateTxCompleted: 0 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 2 RowDeletes: 0 RowReads: 7 RangeReads: 0 PartCount: 0 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 0 HasLoanedParts: false ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0 } TabletMetrics { Memory: 82488 } ShardState: 2 UserTablePartOwners: 72075186224037891 NodeId: 1 StartTime: 1744236221043 TableOwnerId: 72057594046644480 FollowerId: 0
2025-04-09T22:03:51.061681Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-04-09T22:03:51.061719Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037891 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 12] state 'Ready' dataSize 656 rowCount 2 cpuUsage 0
2025-04-09T22:03:51.061817Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037891 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 12] raw table stats:
DataSize: 656 RowCount: 2 IndexSize: 0 InMemSize: 656 LastAccessTime: 1744236230415 LastUpdateTime: 1744236221216 ImmediateTxCompleted: 0 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 2 RowDeletes: 0 RowReads: 7 RangeReads: 0 PartCount: 0 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 0 HasLoanedParts: false ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0
2025-04-09T22:03:51.061840Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.099995s, queue# 1
2025-04-09T22:03:51.094539Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:51.094605Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.094626Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.094669Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:51.094743Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:51.094761Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:51.094788Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:51.161190Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435092, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-04-09T22:03:51.161233Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-04-09T22:03:51.161250Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: Started TEvPersistStats at tablet 72057594046644480, queue size# 1
2025-04-09T22:03:51.161303Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 1
2025-04-09T22:03:51.161321Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.000517s, queue# 1
2025-04-09T22:03:51.161386Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: PersistSingleStats for pathId 12 shard idx 72057594046644480:4 data size 656 row count 2
2025-04-09T22:03:51.161456Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: TTxStoreTableStats.PersistSingleStats: main stats from datashardId(TabletID)=72075186224037891 maps to shardIdx: 72057594046644480:4 followerId=0, pathId: [OwnerId: 72057594046644480, LocalPathId: 12], pathId map=Versions, is column=0, is olap=0, RowCount 2, DataSize 656
2025-04-09T22:03:51.161471Z node 1 :FLAT_TX_SCHEMESHARD TRACE: BuildStatsForCollector: datashardId 72075186224037891, followerId 0
2025-04-09T22:03:51.161541Z node 1 :FLAT_TX_SCHEMESHARD TRACE: [BackgroundCompaction] [Update] Skipped shard# 72057594046644480:4 with partCount# 0, rowCount# 2, searchHeight# 1, lastFullCompaction# 1970-01-01T00:00:00.000000Z at schemeshard 72057594046644480
2025-04-09T22:03:51.161645Z node 1 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-04-09T22:03:51.162166Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435092, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-04-09T22:03:51.162188Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-04-09T22:03:51.162200Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-04-09T22:03:51.196776Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:51.196864Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.196886Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.196944Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:51.197014Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:51.197032Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:51.197059Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:51.297334Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:51.297407Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.297430Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.297469Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:51.297539Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:51.297557Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:51.297582Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:51.380811Z node 1 :PERSQUEUE TRACE: HandleHook, received event# 65538, Sender [0:0:0], Recipient [1:7491437549015654441:2455]: NActors::TEvents::TEvWakeup
2025-04-09T22:03:51.400748Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:51.400819Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.400843Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.400888Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:51.400965Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:51.400983Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:51.401010Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:51.438906Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] TPersQueueReadBalancer::HandleWakeup
2025-04-09T22:03:51.438950Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] Send TEvPersQueue::TEvStatus TabletId: 72075186224037892 Cookie: 5
2025-04-09T22:03:51.439086Z node 1 :PERSQUEUE TRACE: StateIdle event# 65538 (NActors::TEvents::TEvWakeup), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:51.439128Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 65538, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NActors::TEvents::TEvWakeup
2025-04-09T22:03:51.439342Z node 1 :PERSQUEUE TRACE: HandleHook, received event# 271188501, Sender [1:7491437549015654486:2458], Recipient [1:7491437549015654441:2455]: NKikimr::TEvPQ::TEvPartitionCounters
2025-04-09T22:03:51.439361Z node 1 :PERSQUEUE TRACE: HandleHook, processing event TEvPQ::TEvPartitionCounters
2025-04-09T22:03:51.439374Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892] Handle TEvPQ::TEvPartitionCounters PartitionId 0
2025-04-09T22:03:51.439534Z node 1 :PERSQUEUE TRACE: HandleHook, received event# 271188503, Sender [1:7491437549015654486:2458], Recipient [1:7491437549015654441:2455]: NKikimr::TEvPQ::TEvPartitionLabeledCounters
2025-04-09T22:03:51.439546Z node 1 :PERSQUEUE TRACE: HandleHook, processing event TEvPQ::TEvPartitionLabeledCounters
2025-04-09T22:03:51.444686Z node 1 :PERSQUEUE TRACE: HandleHook, received event# 271187975, Sender [1:7491437549015654420:2454], Recipient [1:7491437549015654441:2455]: NKikimrPQ.TStatus GetStatForAllConsumers: true
2025-04-09T22:03:51.444723Z node 1 :PERSQUEUE TRACE: HandleHook, processing event TEvPersQueue::TEvStatus
2025-04-09T22:03:51.444738Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892] Handle TEvPersQueue::TEvStatus
2025-04-09T22:03:51.444817Z node 1 :PERSQUEUE TRACE: HandleHook, received event# 271188536, Sender [1:7491437549015654420:2454], Recipient [1:7491437549015654441:2455]: NKikimrPQ.TEvSubDomainStatus SubDomainOutOfSpace: false
2025-04-09T22:03:51.444831Z node 1 :PERSQUEUE TRACE: HandleHook, processing event TEvPQ::TEvSubDomainStatus
2025-04-09T22:03:51.444921Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188491 (NKikimr::TEvPQ::TEvPartitionStatus), Tablet [1:7491437549015654441:2455], Partition 0, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:51.444956Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188491, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvPartitionStatus
2025-04-09T22:03:51.444971Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvPartitionStatus
2025-04-09T22:03:51.445138Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Topic PartitionStatus PartitionSize: 0 UsedReserveSize: 0 ReserveSize: 0 PartitionConfig{ MaxCountInPartition: 2147483647 LifetimeSeconds: 86400 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 1048576 BurstSize: 1048576 TotalPartitions: 1 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 }
2025-04-09T22:03:51.445214Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188536 (NKikimr::TEvPQ::TEvSubDomainStatus), Tablet [1:7491437549015654441:2455], Partition 0, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:51.445248Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188536, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458]: NKikimrPQ.TEvSubDomainStatus SubDomainOutOfSpace: false
2025-04-09T22:03:51.445262Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvSubDomainStatus
2025-04-09T22:03:51.445602Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] Send TEvPeriodicTopicStats PathId: 13 Generation: 1 StatsReportRound: 5 DataSize: 0 UsedReserveSize: 0
2025-04-09T22:03:51.445702Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] ProcessPendingStats. PendingUpdates size 1
2025-04-09T22:03:51.445891Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271188001, Sender [1:7491437549015654420:2454], Recipient [1:7491437514655915003:2189]: NKikimrPQ.TEvPeriodicTopicStats PathId: 13 Generation: 1 Round: 5 DataSize: 0 UsedReserveSize: 0 SubDomainOutOfSpace: false
2025-04-09T22:03:51.445912Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPersQueue::TEvPeriodicTopicStats
2025-04-09T22:03:51.445930Z node 1 :FLAT_TX_SCHEMESHARD INFO: Got periodic topic stats at partition [OwnerId: 72057594046644480, LocalPathId: 13] DataSize 0 UsedReserveSize 0
2025-04-09T22:03:51.445951Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTopicStats on# 0.099996s, queue# 1
2025-04-09T22:03:51.446960Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122945, Sender [1:7491437549015654420:2454], Recipient [1:7491437514655915003:2189]: NKikimrSchemeOp.TDescribePath PathId: 13 SchemeshardId: 72057594046644480
2025-04-09T22:03:51.446982Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvDescribeScheme
2025-04-09T22:03:51.486754Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-04-09T22:03:51.486791Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-04-09T22:03:51.486857Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [1:7491437514655915003:2189], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-04-09T22:03:51.486870Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-04-09T22:03:51.501497Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:51.501572Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.501592Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.501633Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:51.501703Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:51.501721Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:51.501743Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:51.548695Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435095, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:51.548729Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:51.548744Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: Started TEvPersistStats at tablet 72057594046644480, queue size# 1
2025-04-09T22:03:51.548751Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 1
2025-04-09T22:03:51.548800Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTopicStats on# 0.000000s, queue# 1
2025-04-09T22:03:51.549208Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435095, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:51.549234Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:51.549246Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-04-09T22:03:51.608723Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:51.608796Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.608813Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.608847Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:51.608906Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:51.608926Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:51.608953Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:51.609076Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188544 (NKikimr::NPQ::NReadQuoterEvents::TEvQuotaCountersUpdated), Tablet [1:7491437549015654441:2455], Partition 0, Sender [1:7491437549015654490:2460], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:51.609115Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188544, Sender [1:7491437549015654490:2460], Recipient [1:7491437549015654486:2458]: NKikimr::NPQ::NReadQuoterEvents::TEvQuotaCountersUpdated
2025-04-09T22:03:51.609129Z node 1 :PERSQUEUE TRACE: StateIdle, processing event NReadQuoterEvents::TEvQuotaCountersUpdated
2025-04-09T22:03:51.716384Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:51.716454Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.716472Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.716505Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:51.716726Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:51.716745Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:51.716766Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:51.816719Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:51.816796Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.816818Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.816859Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:51.816933Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:51.816951Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:51.816976Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:51.924779Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:51.924849Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.924868Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:51.924907Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:51.924973Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:51.924988Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:51.925010Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:52.024893Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:52.024977Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.025000Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.025041Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:52.025112Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:52.025129Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:52.025154Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:52.127121Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:52.127180Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.127198Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.127235Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:52.127292Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:52.127309Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:52.127333Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:52.228340Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:52.228415Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.228437Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.228479Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:52.228573Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:52.228590Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:52.228619Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:52.332675Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:52.332741Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.332762Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.332803Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:52.332872Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:52.332889Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:52.332915Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:52.432975Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:52.433031Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.433047Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.433076Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:52.433135Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:52.433148Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:52.433169Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:52.439151Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] TPersQueueReadBalancer::HandleWakeup
2025-04-09T22:03:52.439214Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] Send TEvPersQueue::TEvStatus TabletId: 72075186224037892 Cookie: 6
2025-04-09T22:03:52.439477Z node 1 :PERSQUEUE TRACE: HandleHook, received event# 271187975, Sender [1:7491437549015654420:2454], Recipient [1:7491437549015654441:2455]: NKikimrPQ.TStatus GetStatForAllConsumers: true
2025-04-09T22:03:52.439499Z node 1 :PERSQUEUE TRACE: HandleHook, processing event TEvPersQueue::TEvStatus
2025-04-09T22:03:52.439519Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892] Handle TEvPersQueue::TEvStatus
2025-04-09T22:03:52.439589Z node 1 :PERSQUEUE TRACE: HandleHook, received event# 271188536, Sender [1:7491437549015654420:2454], Recipient [1:7491437549015654441:2455]: NKikimrPQ.TEvSubDomainStatus SubDomainOutOfSpace: false
2025-04-09T22:03:52.439604Z node 1 :PERSQUEUE TRACE: HandleHook, processing event TEvPQ::TEvSubDomainStatus
2025-04-09T22:03:52.439703Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188491 (NKikimr::TEvPQ::TEvPartitionStatus), Tablet [1:7491437549015654441:2455], Partition 0, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:52.439745Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188491, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvPartitionStatus
2025-04-09T22:03:52.439762Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvPartitionStatus
2025-04-09T22:03:52.439957Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Topic PartitionStatus PartitionSize: 0 UsedReserveSize: 0 ReserveSize: 0 PartitionConfig{ MaxCountInPartition: 2147483647 LifetimeSeconds: 86400 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 1048576 BurstSize: 1048576 TotalPartitions: 1 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 }
2025-04-09T22:03:52.440057Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188536 (NKikimr::TEvPQ::TEvSubDomainStatus), Tablet [1:7491437549015654441:2455], Partition 0, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:52.440092Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188536, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458]: NKikimrPQ.TEvSubDomainStatus SubDomainOutOfSpace: false
2025-04-09T22:03:52.440106Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvSubDomainStatus
2025-04-09T22:03:52.440144Z node 1 :PERSQUEUE TRACE: HandleHook, received event# 271188503, Sender [1:7491437549015654486:2458], Recipient [1:7491437549015654441:2455]: NKikimr::TEvPQ::TEvPartitionLabeledCounters
2025-04-09T22:03:52.440158Z node 1 :PERSQUEUE TRACE: HandleHook, processing event TEvPQ::TEvPartitionLabeledCounters
2025-04-09T22:03:52.440501Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] Send TEvPeriodicTopicStats PathId: 13 Generation: 1 StatsReportRound: 6 DataSize: 0 UsedReserveSize: 0
2025-04-09T22:03:52.440608Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] ProcessPendingStats. PendingUpdates size 1
2025-04-09T22:03:52.440871Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271188001, Sender [1:7491437549015654420:2454], Recipient [1:7491437514655915003:2189]: NKikimrPQ.TEvPeriodicTopicStats PathId: 13 Generation: 1 Round: 6 DataSize: 0 UsedReserveSize: 0 SubDomainOutOfSpace: false
2025-04-09T22:03:52.440898Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPersQueue::TEvPeriodicTopicStats
2025-04-09T22:03:52.440931Z node 1 :FLAT_TX_SCHEMESHARD INFO: Got periodic topic stats at partition [OwnerId: 72057594046644480, LocalPathId: 13] DataSize 0 UsedReserveSize 0
2025-04-09T22:03:52.440955Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTopicStats on# 0.099995s, queue# 1
2025-04-09T22:03:52.447501Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122945, Sender [1:7491437549015654420:2454], Recipient [1:7491437514655915003:2189]: NKikimrSchemeOp.TDescribePath PathId: 13 SchemeshardId: 72057594046644480
2025-04-09T22:03:52.447546Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvDescribeScheme
2025-04-09T22:03:52.487232Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-04-09T22:03:52.487272Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-04-09T22:03:52.487326Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [1:7491437514655915003:2189], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-04-09T22:03:52.487342Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-04-09T22:03:52.533715Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:52.533789Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.533812Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.533854Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:52.533930Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:52.533949Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:52.533976Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:52.543291Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435095, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:52.543335Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:52.543367Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: Started TEvPersistStats at tablet 72057594046644480, queue size# 1
2025-04-09T22:03:52.543379Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 1
2025-04-09T22:03:52.543445Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTopicStats on# 0.000000s, queue# 1
2025-04-09T22:03:52.551854Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435095, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:52.551900Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:52.551919Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-04-09T22:03:52.609665Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188544 (NKikimr::NPQ::NReadQuoterEvents::TEvQuotaCountersUpdated), Tablet [1:7491437549015654441:2455], Partition 0, Sender [1:7491437549015654490:2460], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:52.609732Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188544, Sender [1:7491437549015654490:2460], Recipient [1:7491437549015654486:2458]: NKikimr::NPQ::NReadQuoterEvents::TEvQuotaCountersUpdated
2025-04-09T22:03:52.609753Z node 1 :PERSQUEUE TRACE: StateIdle, processing event NReadQuoterEvents::TEvQuotaCountersUpdated
2025-04-09T22:03:52.634152Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:52.634225Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.634248Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.634290Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:52.634361Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:52.634378Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:52.634403Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:52.736765Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:52.736824Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.736843Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.736880Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:52.736944Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:52.736960Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:52.736981Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:52.855899Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:52.855968Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.855985Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.856018Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:52.856081Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:52.856096Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:52.856119Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:52.956184Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:52.956258Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.956276Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:52.956310Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:52.956366Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:52.956384Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:52.956407Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:53.056665Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:53.056727Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.056745Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.056780Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:53.056838Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:53.056854Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:53.056878Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:53.158094Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:53.158160Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.158181Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.158220Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:53.158281Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:53.158296Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:53.158320Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:53.258266Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:53.258342Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.258362Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.258396Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:53.258452Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:53.258477Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:53.258500Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:53.358646Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:53.358731Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.358756Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.358799Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:53.358872Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:53.358889Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:53.358916Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:53.439481Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] TPersQueueReadBalancer::HandleWakeup
2025-04-09T22:03:53.439534Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] Send TEvPersQueue::TEvStatus TabletId: 72075186224037892 Cookie: 7
2025-04-09T22:03:53.440814Z node 1 :PERSQUEUE TRACE: HandleHook, received event# 271187975, Sender [1:7491437549015654420:2454], Recipient [1:7491437549015654441:2455]: NKikimrPQ.TStatus GetStatForAllConsumers: true
2025-04-09T22:03:53.440850Z node 1 :PERSQUEUE TRACE: HandleHook, processing event TEvPersQueue::TEvStatus
2025-04-09T22:03:53.440868Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892] Handle TEvPersQueue::TEvStatus
2025-04-09T22:03:53.440964Z node 1 :PERSQUEUE TRACE: HandleHook, received event# 271188536, Sender [1:7491437549015654420:2454], Recipient [1:7491437549015654441:2455]: NKikimrPQ.TEvSubDomainStatus SubDomainOutOfSpace: false
2025-04-09T22:03:53.440987Z node 1 :PERSQUEUE TRACE: HandleHook, processing event TEvPQ::TEvSubDomainStatus
2025-04-09T22:03:53.441094Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188491 (NKikimr::TEvPQ::TEvPartitionStatus), Tablet [1:7491437549015654441:2455], Partition 0, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:53.441145Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188491, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvPartitionStatus
2025-04-09T22:03:53.441169Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvPartitionStatus
2025-04-09T22:03:53.441360Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Topic PartitionStatus PartitionSize: 0 UsedReserveSize: 0 ReserveSize: 0 PartitionConfig{ MaxCountInPartition: 2147483647 LifetimeSeconds: 86400 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 1048576 BurstSize: 1048576 TotalPartitions: 1 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 }
2025-04-09T22:03:53.441469Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188536 (NKikimr::TEvPQ::TEvSubDomainStatus), Tablet [1:7491437549015654441:2455], Partition 0, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:53.441510Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188536, Sender [1:7491437549015654441:2455], Recipient [1:7491437549015654486:2458]: NKikimrPQ.TEvSubDomainStatus SubDomainOutOfSpace: false
2025-04-09T22:03:53.441529Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvSubDomainStatus
2025-04-09T22:03:53.441573Z node 1 :PERSQUEUE TRACE: HandleHook, received event# 271188503, Sender [1:7491437549015654486:2458], Recipient [1:7491437549015654441:2455]: NKikimr::TEvPQ::TEvPartitionLabeledCounters
2025-04-09T22:03:53.441598Z node 1 :PERSQUEUE TRACE: HandleHook, processing event TEvPQ::TEvPartitionLabeledCounters
2025-04-09T22:03:53.441962Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] Send TEvPeriodicTopicStats PathId: 13 Generation: 1 StatsReportRound: 7 DataSize: 0 UsedReserveSize: 0
2025-04-09T22:03:53.442063Z node 1 :PERSQUEUE_READ_BALANCER DEBUG: [72075186224037893][test-topic] ProcessPendingStats. PendingUpdates size 1
2025-04-09T22:03:53.442434Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271188001, Sender [1:7491437549015654420:2454], Recipient [1:7491437514655915003:2189]: NKikimrPQ.TEvPeriodicTopicStats PathId: 13 Generation: 1 Round: 7 DataSize: 0 UsedReserveSize: 0 SubDomainOutOfSpace: false
2025-04-09T22:03:53.442468Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPersQueue::TEvPeriodicTopicStats
2025-04-09T22:03:53.442485Z node 1 :FLAT_TX_SCHEMESHARD INFO: Got periodic topic stats at partition [OwnerId: 72057594046644480, LocalPathId: 13] DataSize 0 UsedReserveSize 0
2025-04-09T22:03:53.442512Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTopicStats on# 0.099995s, queue# 1
2025-04-09T22:03:53.452656Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122945, Sender [1:7491437549015654420:2454], Recipient [1:7491437514655915003:2189]: NKikimrSchemeOp.TDescribePath PathId: 13 SchemeshardId: 72057594046644480
2025-04-09T22:03:53.452700Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvDescribeScheme
2025-04-09T22:03:53.460687Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:53.460762Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.460785Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.460826Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:53.460906Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:53.460922Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:53.460949Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:53.465745Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435093, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvPrivate::TEvConsoleConfigsTimeout
2025-04-09T22:03:53.465786Z node 1 :FLAT_TX_SCHEMESHARD WARN: Cannot get console configs
2025-04-09T22:03:53.465796Z node 1 :IMPORT WARN: Table profiles were not loaded
2025-04-09T22:03:53.488996Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-04-09T22:03:53.489053Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-04-09T22:03:53.489110Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [1:7491437514655915003:2189], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-04-09T22:03:53.489125Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-04-09T22:03:53.548734Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435095, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:53.548783Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:53.548810Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: Started TEvPersistStats at tablet 72057594046644480, queue size# 1
2025-04-09T22:03:53.548820Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 1
2025-04-09T22:03:53.548887Z node 1 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTopicStats on# 0.000000s, queue# 1
2025-04-09T22:03:53.549445Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435095, Sender [0:0:0], Recipient [1:7491437514655915003:2189]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:53.549462Z node 1 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTopicStats
2025-04-09T22:03:53.549474Z node 1 :FLAT_TX_SCHEMESHARD DEBUG: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-04-09T22:03:53.561366Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:53.561451Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.561471Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.561513Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:53.561584Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:53.561603Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:53.561629Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:53.610110Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188544 (NKikimr::NPQ::NReadQuoterEvents::TEvQuotaCountersUpdated), Tablet [1:7491437549015654441:2455], Partition 0, Sender [1:7491437549015654490:2460], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:53.610179Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188544, Sender [1:7491437549015654490:2460], Recipient [1:7491437549015654486:2458]: NKikimr::NPQ::NReadQuoterEvents::TEvQuotaCountersUpdated
2025-04-09T22:03:53.610200Z node 1 :PERSQUEUE TRACE: StateIdle, processing event NReadQuoterEvents::TEvQuotaCountersUpdated
2025-04-09T22:03:53.661730Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:53.661793Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.661807Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.661843Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:53.661905Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:53.661937Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:53.661962Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
2025-04-09T22:03:53.762121Z node 1 :PERSQUEUE TRACE: StateIdle event# 271188505 (NKikimr::TEvPQ::TEvUpdateAvailableSize), Tablet [1:7491437549015654441:2455], Partition 0, Sender [0:0:0], Recipient [1:7491437549015654486:2458], Cookie: 0
2025-04-09T22:03:53.762193Z node 1 :PERSQUEUE TRACE: StateIdle, received event# 271188505, Sender [0:0:0], Recipient [1:7491437549015654486:2458]: NKikimr::TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.762218Z node 1 :PERSQUEUE TRACE: StateIdle, processing event TEvPQ::TEvUpdateAvailableSize
2025-04-09T22:03:53.762262Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete old stuff
2025-04-09T22:03:53.762335Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Have 0 items to delete all stuff. Delete command NKikimrClient.TKeyValueRequest 
2025-04-09T22:03:53.762354Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::ProcessReserveRequests.
2025-04-09T22:03:53.762397Z node 1 :PERSQUEUE TRACE: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::AnswerCurrentWrites. Responses.size()=0
    #0 0x18ee3551 in __asan_memcpy /-S/contrib/libs/clang18-rt/lib/asan/asan_interceptors_memintrinsics.cpp:63:3
    #1 0x19169701 in MemCopy<char> /-S/util/generic/mem_copy.h:18:9
    #2 0x19169701 in TBuffer::Append(char const*, unsigned long) /-S/util/generic/buffer.cpp:54:5
    #3 0x1fc41f46 in Acquire /-S/ydb/public/sdk/cpp/src/client/topic/impl/write_session_impl.h:208:18
    #4 0x1fc41f46 in NYdb::Dev::NTopic::TWriteSessionImpl::FlushWriteIfRequiredImpl() /-S/ydb/public/sdk/cpp/src/client/topic/impl/write_session_impl.cpp:1366:64
    #5 0x1fc414f0 in NYdb::Dev::NTopic::TWriteSessionImpl::WriteInternal(NYdb::Dev::NTopic::TContinuationToken&&, NYdb::Dev::NTopic::TWriteMessage&&) /-S/ydb/public/sdk/cpp/src/client/topic/impl/write_session_impl.cpp:660:9
    #6 0x1fc1a871 in NYdb::Dev::NTopic::TWriteSession::Write(NYdb::Dev::NTopic::TContinuationToken&&, NYdb::Dev::NTopic::TWriteMessage&&, NYdb::Dev::NTable::TTransaction*) /-S/ydb/public/sdk/cpp/src/client/topic/impl/write_session.cpp:72:19
    #7 0x1fc1c81e in NYdb::Dev::NTopic::TSimpleBlockingWriteSession::Write(NYdb::Dev::NTopic::TWriteMessage&&, NYdb::Dev::NTable::TTransaction*, TDuration const&) /-S/ydb/public/sdk/cpp/src/client/topic/impl/write_session.cpp:131:17
    #8 0x18e470cc in NKikimr::NTestSuiteWithSDK::TTestCaseDescribeConsumer::Execute_(NUnitTest::TTestContext&)::$_1::operator()(unsigned long) const /-S/ydb/core/persqueue/ut/ut_with_sdk/topic_ut.cpp:52:13
    #9 0x18e20842 in NKikimr::NTestSuiteWithSDK::TTestCaseDescribeConsumer::Execute_(NUnitTest::TTestContext&) /-S/ydb/core/persqueue/ut/ut_with_sdk/topic_ut.cpp:76:9
    #10 0x18e4da27 in operator() /-S/ydb/core/persqueue/ut/ut_with_sdk/topic_ut.cpp:31:1
    #11 0x18e4da27 in __invoke<(lambda at /-S/ydb/core/persqueue/ut/ut_with_sdk/topic_ut.cpp:31:1) &> /-S/contrib/libs/cxxsupp/libcxx/include/__type_traits/invoke.h:150:25
    #12 0x18e4da27 in __call<(lambda at /-S/ydb/core/persqueue/ut/ut_with_sdk/topic_ut.cpp:31:1) &> /-S/contrib/libs/cxxsupp/libcxx/include/__type_traits/invoke.h:225:5
    #13 0x18e4da27 in operator() /-S/contrib/libs/cxxsupp/libcxx/include/__functional/function.h:171:12
    #14 0x18e4da27 in std::__y1::__function::__func<NKikimr::NTestSuiteWithSDK::TCurrentTest::Execute()::'lambda'(), std::__y1::allocator<NKikimr::NTestSuiteWithSDK::TCurrentTest::Execute()::'lambda'()>, void ()>::operator()() /-S/contrib/libs/cxxsupp/libcxx/include/__functional/function.h:313:10
    #15 0x196dd995 in operator() /-S/contrib/libs/cxxsupp/libcxx/include/__functional/function.h:430:12
    #16 0x196dd995 in operator() /-S/contrib/libs/cxxsupp/libcxx/include/__functional/function.h:989:10
    #17 0x196dd995 in TColoredProcessor::Run(std::__y1::function<void ()>, TBasicString<char, std::__y1::char_traits<char>> const&, char const*, bool) /-S/library/cpp/testing/unittest/utmain.cpp:525:20
    #18 0x196ad4c8 in NUnitTest::TTestBase::Run(std::__y1::function<void ()>, TBasicString<char, std::__y1::char_traits<char>> const&, char const*, bool) /-S/library/cpp/testing/unittest/registar.cpp:374:18
    #19 0x18e4cbf3 in NKikimr::NTestSuiteWithSDK::TCurrentTest::Execute() /-S/ydb/core/persqueue/ut/ut_with_sdk/topic_ut.cpp:31:1
    #20 0x196aed95 in NUnitTest::TTestFactory::Execute() /-S/library/cpp/testing/unittest/registar.cpp:495:19
    #21 0x196d7f0c in NUnitTest::RunMain(int, char**) /-S/library/cpp/testing/unittest/utmain.cpp:872:44
    #22 0x7fbfc372ad8f  (/lib/x86_64-linux-gnu/libc.so.6+0x29d8f) (BuildId: 490fef8403240c91833978d494d39e537409b92e)
    #23 0x7fbfc372ae3f in __libc_start_main (/lib/x86_64-linux-gnu/libc.so.6+0x29e3f) (BuildId: 490fef8403240c91833978d494d39e537409b92e)
    #24 0x165a8028 in _start (/home/runner/actions_runner/_work/ydb/ydb/tmp/out/ydb/core/persqueue/ut/ut_with_sdk/ydb-core-persqueue-ut-ut_with_sdk+0x165a8028) (BuildId: 7b4dc4363b0ae9f51a8c85f4c2bd6b24143de24f)
SUMMARY: AddressSanitizer: heap-use-after-free /-S/contrib/libs/clang18-rt/lib/asan/asan_interceptors_memintrinsics.cpp:63:3 in __asan_memcpy
Shadow bytes around the buggy address:
  0x5030050b3c80: fa fa fa fa fa fa fa fa fa fa fa fa fa fa fa fa
  0x5030050b3d00: fa fa fa fa fd fd fd fd fa fa fd fd fd fd fa fa
  0x5030050b3d80: fa fa fa fa fa fa fa fa fa fa fa fa fd fd fd fd
  0x5030050b3e00: fa fa fa fa fa fa fa fa fd fd fd fd fa fa 00 00
  0x5030050b3e80: 00 fa fa fa fd fd fd fd fa fa fd fd fd fd fa fa
=>0x5030050b3f00: fd fd fd fd fa fa fd[fd]fd fd fa fa fd fd fd fd
  0x5030050b3f80: fa fa fd fd fd fd fa fa fd fd fd fd fa fa fd fd
  0x5030050b4000: fd fa fa fa 00 00 00 fa fa fa fd fd fd fd fa fa
  0x5030050b4080: fd fd fd fa fa fa fd fd fd fd fa fa fd fd fd fd
  0x5030050b4100: fa fa fd fd fd fd fa fa fd fd fd fd fa fa fd fd
  0x5030050b4180: fd fd fa fa fd fd fd fd fa fa fd fd fd fd fa fa
Shadow byte legend (one shadow byte represents 8 application bytes):
  Addressable:           00
  Partially addressable: 01 02 03 04 05 06 07 
  Heap left redzone:       fa
  Freed heap region:       fd
  Stack left redzone:      f1
  Stack mid redzone:       f2
  Stack right redzone:     f3
  Stack after return:      f5
  Stack use after scope:   f8
  Global redzone:          f9
  Global init order:       f6
  Poisoned by user:        f7
  Container overflow:      fc
  Array cookie:            ac
  Intra object redzone:    bb
  ASan internal:           fe
  Left alloca redzone:     ca
  Right alloca redzone:    cb
==1051183==ABORTING

logsdir:
/home/runner/actions_runner/_work/ydb/ydb/tmp/out/ydb/core/persqueue/ut/ut_with_sdk/test-results/unittest/testing_out_stuff
stderr:
/home/runner/actions_runner/_work/ydb/ydb/tmp/out/ydb/core/persqueue/ut/ut_with_sdk/test-results/unittest/testing_out_stuff/WithSDK.DescribeConsumer.err
stdout:
/home/runner/actions_runner/_work/ydb/ydb/tmp/out/ydb/core/persqueue/ut/ut_with_sdk/test-results/unittest/testing_out_stuff/WithSDK.DescribeConsumer.out