2025-12-04T15:16:50.383175Z node 11 :METADATA_PROVIDER WARN: log.cpp:841: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[11:7580022038275234916:2089];send_to=[0:7307199536658146131:7762515];
2025-12-04T15:16:50.383210Z node 11 :METADATA_PROVIDER ERROR: log.cpp:841: fline=accessor_snapshot_base.cpp:71;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=scheme_cache_undelivered_message;
2025-12-04T15:16:50.387473Z node 11 :PQ_READ_PROXY DEBUG: caching_service.cpp:44: Direct read cache: : Created
test_client.cpp: SetPath # /home/runner/.ya/build/build_root/wqn8/00564e/r3tmp/tmpNOLAPD/pdisk_1.dat
2025-12-04T15:16:50.388686Z node 12 :KQP_PROXY WARN: kqp_finalize_script_service.cpp:135: [ScriptExecutions] [TKqpFinalizeScriptService] Failed to check script execution tables existence, scheme status: LookupError, path: Root/.metadata/script_executions
2025-12-04T15:16:50.388723Z node 12 :PQ_READ_PROXY DEBUG: caching_service.cpp:44: Direct read cache: : Created
2025-12-04T15:16:50.388810Z node 12 :METADATA_PROVIDER ERROR: log.cpp:841: fline=accessor_snapshot_base.cpp:71;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=incorrect path status: LookupError;
2025-12-04T15:16:50.388825Z node 11 :KQP_PROXY WARN: kqp_finalize_script_service.cpp:135: [ScriptExecutions] [TKqpFinalizeScriptService] Failed to check script execution tables existence, scheme status: LookupError, path: Root/.metadata/script_executions
2025-12-04T15:16:50.407569Z node 11 :IMPORT WARN: schemeshard_import.cpp:423: Table profiles were not loaded
2025-12-04T15:16:50.418468Z node 11 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(12, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-12-04T15:16:50.418499Z node 11 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(12, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-12-04T15:16:50.421292Z node 11 :HIVE WARN: hive_impl.cpp:811: HIVE#72057594037968897 Handle TEvInterconnect::TEvNodeConnected, NodeId 12 Cookie 12
2025-12-04T15:16:50.421579Z node 11 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(12, (0,0,0,0)) VolatileState: Connecting -> Connected
TServer::EnableGrpc on GrpcPort 17777, node 11
2025-12-04T15:16:50.432530Z node 11 :NET_CLASSIFIER WARN: net_classifier.cpp:190: distributable config is empty, broken or outdated, will use file: /home/runner/.ya/build/build_root/wqn8/00564e/r3tmp/yandexvmdldH.tmp
2025-12-04T15:16:50.432541Z node 11 :NET_CLASSIFIER WARN: net_classifier.cpp:196: will try to initialize from file: /home/runner/.ya/build/build_root/wqn8/00564e/r3tmp/yandexvmdldH.tmp
2025-12-04T15:16:50.436889Z INFO: TTestServer started on Port 15324 GrpcPort 17777
2025-12-04T15:16:50.440766Z node 11 :NET_CLASSIFIER WARN: net_classifier.cpp:202: successfully initialized from file: /home/runner/.ya/build/build_root/wqn8/00564e/r3tmp/yandexvmdldH.tmp
2025-12-04T15:16:50.440819Z node 11 :NET_CLASSIFIER ERROR: net_classifier.cpp:228: got bad distributable configuration
TClient is connected to server localhost:15324
PQClient connected to localhost:17777
WaitRootIsUp 'Root'...
TClient::Ls request: Root
TClient::Ls response: Status: 1
StatusCode: SUCCESS
SchemeStatus: 0
PathDescription {
  Self {
    Name: "Root"
    PathId: 1
    SchemeshardId: 72057594046644480
    PathType: EPathTypeDir
    CreateFinished: true
    CreateTxId: 1
    CreateStep: 0
    ParentPathId: 1
    PathState: EPathStateNoChanges
    Owner: "root@builtin"
    ACL: ""
    EffectiveACL: ""
    PathVersion: 2
    PathSubType: EPathSubTypeEmpty
    Version {
      GeneralVersion: 2
      ACLVersion: 0
      EffectiveACLVersion: 0
      UserAttrsVersion: 1
      ChildrenVersion: 1
      SubDomainVersion: 0
      SecurityStateVersion: 0
    }
    ChildrenExist: false
  }
  Children {
    Name: ".sys"
    PathId: 18446744073709551615
    SchemeshardId: 72057594046644480
    PathType: EPathTypeDir
    CreateFinished: true
    CreateTxId: 0
    CreateStep: 0
    ParentPathId: 18446744073709551615
  }
  DomainDescription {
    SchemeShardId_Depricated: 72057594046644480
    PathId_Depricated: 1
    ProcessingParams {
      Version: 0
      Pl...
(TRUNCATED)
WaitRootIsUp 'Root' success.
2025-12-04T15:16:50.485205Z node 11 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(11, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-12-04T15:16:50.485257Z node 11 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(11, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-12-04T15:16:50.486789Z node 11 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(11, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-12-04T15:16:50.487586Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 281474976720657:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at ydb/core/tx/schemeshard/schemeshard__operation_alter_subdomain.cpp:311)
waiting...
waiting...
2025-12-04T15:16:50.503758Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976720659:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:690)
waiting...
waiting...
waiting...
2025-12-04T15:16:50.611034Z node 12 :KQP_PROXY WARN: kqp_finalize_script_service.cpp:135: [ScriptExecutions] [TKqpFinalizeScriptService] Failed to check script execution tables existence, scheme status: PathErrorUnknown, path: Root/.metadata/script_executions
2025-12-04T15:16:50.666630Z node 11 :KQP_PROXY WARN: kqp_finalize_script_service.cpp:135: [ScriptExecutions] [TKqpFinalizeScriptService] Failed to check script execution tables existence, scheme status: PathErrorUnknown, path: Root/.metadata/script_executions
2025-12-04T15:16:50.802205Z node 11 :KQP_WORKLOAD_SERVICE WARN: scheme_actors.cpp:225: [WorkloadService] [TPoolFetcherActor] ActorId: [11:7580022038275235958:2330], DatabaseId: /Root, PoolId: default, Failed to fetch pool info, NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-04T15:16:50.802214Z node 11 :KQP_WORKLOAD_SERVICE WARN: scheme_actors.cpp:225: [WorkloadService] [TPoolFetcherActor] ActorId: [11:7580022038275235970:2333], DatabaseId: /Root, PoolId: default, Failed to fetch pool info, NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-04T15:16:50.802228Z node 11 :KQP_WORKLOAD_SERVICE WARN: kqp_workload_service.cpp:263: [WorkloadService] [Service] Failed to fetch pool default, DatabaseId: /Root, status: NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-04T15:16:50.802312Z node 11 :KQP_WORKLOAD_SERVICE WARN: scheme_actors.cpp:225: [WorkloadService] [TPoolFetcherActor] ActorId: [11:7580022038275235987:2334], DatabaseId: /Root, PoolId: default, Failed to fetch pool info, NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-04T15:16:50.802328Z node 11 :KQP_WORKLOAD_SERVICE WARN: kqp_workload_service.cpp:263: [WorkloadService] [Service] Failed to fetch pool default, DatabaseId: /Root, status: NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-04T15:16:50.802784Z node 11 :KQP_WORKLOAD_SERVICE WARN: scheme_actors.cpp:225: [WorkloadService] [TPoolFetcherActor] ActorId: [11:7580022038275236018:2337], DatabaseId: /Root, PoolId: default, Failed to fetch pool info, NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-04T15:16:50.802798Z node 11 :KQP_WORKLOAD_SERVICE WARN: kqp_workload_service.cpp:263: [WorkloadService] [Service] Failed to fetch pool default, DatabaseId: /Root, status: NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-04T15:16:50.802854Z node 11 :KQP_WORKLOAD_SERVICE WARN: scheme_actors.cpp:225: [WorkloadService] [TPoolFetcherActor] ActorId: [11:7580022038275236020:2338], DatabaseId: /Root, PoolId: default, Failed to fetch pool info, NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-04T15:16:50.802862Z node 11 :KQP_WORKLOAD_SERVICE WARN: kqp_workload_service.cpp:263: [WorkloadService] [Service] Failed to fetch pool default, DatabaseId: /Root, status: NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-04T15:16:50.802976Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateResourcePool, opId: 281474976720662:3, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at ydb/core/tx/schemeshard/schemeshard__operation_create_resource_pool.cpp:179)
2025-12-04T15:16:50.808825Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976720663:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:690)
2025-12-04T15:16:50.809041Z node 11 :KQP_WORKLOAD_SERVICE WARN: helpers.h:73: [WorkloadService] [TPoolCreatorActor] ActorId: [11:7580022038275235988:2335], DatabaseId: /Root, PoolId: default, Scheduled retry for error: { <main>: Error: Transaction 281474976720662 completed, doublechecking }
2025-12-04T15:16:50.824650Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976720664:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:690)
2025-12-04T15:16:50.845805Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976720665:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:690)
=== Init DC: UPSERT INTO `/Root/PQ/Config/V2/Cluster` (name, balancer, local, enabled, weight) VALUES ("dc1", "localhost", true, true, 1000), ("dc2", "dc2.logbroker.yandex.net", false, true, 1000);
2025-12-04T15:16:50.880652Z node 11 :TX_PROXY ERROR: schemereq.cpp:593: Actor# [11:7580022038275236413:3043] txid# 281474976720666, issues: { message: "Check failed: path: \'/Root/.metadata/workload_manager/pools/default\', error: path exist, request accepts it (id: [OwnerId: 72057594046644480, LocalPathId: 9], type: EPathTypeResourcePool, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_resource_pool.cpp:92" severity: 1 }
=== CheckClustersList. Subcribe to ClusterTracker from [11:7580022038275236456:3063] 
2025-12-04T15:16:51.385592Z node 11 :TX_CONVEYOR ERROR: log.cpp:841: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-12-04T15:16:51.388180Z node 12 :TX_CONVEYOR ERROR: log.cpp:841: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-12-04T15:16:55.383360Z node 11 :METADATA_PROVIDER ERROR: log.cpp:841: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[11:7580022038275234916:2089];send_to=[0:7307199536658146131:7762515];
2025-12-04T15:16:55.383408Z node 11 :METADATA_PROVIDER ERROR: log.cpp:841: fline=accessor_snapshot_base.cpp:71;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=timeout;
=== CheckClustersList. Ok
CreateTopicNoLegacy: /Root/topic-f1
Create topic: /Root/topic-f1
AddTopic: /Root/topic-f1
===Run query:``DECLARE $version as Int64; DECLARE $path AS Utf8; DECLARE $cluster as Utf8; UPSERT INTO `/Root/PQ/Config/V2/Topics` (path, dc) VALUES ($path, $cluster); UPSERT INTO `/Root/PQ/Config/V2/Versions` (name, version) VALUES ("Topics", $version);`` with topic = /Root/topic-f1, dc = unknown
2025-12-04T15:16:56.143605Z node 11 :PQ_READ_PROXY DEBUG: grpc_pq_schema.cpp:196: new Create topic request
2025-12-04T15:16:56.150268Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2959: [PQ: 72075186224037892] Handle TEvInterconnect::TEvNodeInfo
2025-12-04T15:16:56.150644Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2991: [PQ: 72075186224037892] Transactions request. From tx_00000000000000000000, To tx_18446744073709551615
2025-12-04T15:16:56.150727Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:787: [PQ: 72075186224037892] no config, start with empty partitions and default config
2025-12-04T15:16:56.150741Z node 11 :PERSQUEUE NOTICE: pq_impl.cpp:913: [PQ: 72075186224037892] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-12-04T15:16:56.150756Z node 11 :PERSQUEUE INFO: pq_impl.cpp:612: [PQ: 72075186224037892] doesn't have tx writes info
2025-12-04T15:16:56.150825Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037892] server connected, pipe [11:7580022064045040533:3228], now have 1 active actors on pipe
2025-12-04T15:16:56.151080Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:3563: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-12-04T15:16:56.151448Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:1045: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-12-04T15:16:56.151553Z node 12 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1656: [72075186224037893][] pipe [11:7580022064045040534:3229] connected; active server actors: 1
2025-12-04T15:16:56.151838Z node 12 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer__balancing.cpp:1520: [72075186224037893][topic-f1] updating configuration. Deleted partitions []. Added partitions [0]
2025-12-04T15:16:56.152165Z node 12 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:942: [72075186224037893][topic-f1] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037893
2025-12-04T15:16:56.152682Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037892] server connected, pipe [12:7580022066609499545:2324], now have 1 active actors on pipe
2025-12-04T15:16:56.152736Z node 12 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:404: [72075186224037893][topic-f1] TEvClientConnected TabletId 72075186224037892, NodeId 11, Generation 1
2025-12-04T15:16:56.152955Z node 12 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:140: [72075186224037893][topic-f1] BALANCER INIT DONE for topic-f1: (0, 72075186224037892) 
2025-12-04T15:16:56.154695Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037892] server connected, pipe [11:7580022064045040615:3297], now have 1 active actors on pipe
2025-12-04T15:16:56.154913Z node 11 :PERSQUEUE DEBUG: partition_init.cpp:86: [topic-f1:0:Initializer] Start initializing step TInitConfigStep
2025-12-04T15:16:56.154932Z node 11 :PERSQUEUE DEBUG: partition.cpp:1315: [72075186224037892][Partition][0][StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-12-04T15:16:56.155011Z node 11 :PERSQUEUE DEBUG: partition_init.cpp:86: [topic-f1:0:Initializer] Start initializing step TInitInternalFieldsStep
2025-12-04T15:16:56.155081Z node 11 :PERSQUEUE INFO: partition_init.cpp:1150: [72075186224037892][Partition][0][StateInit] bootstrapping 0 [11:7580022064045040620:2438]
2025-12-04T15:16:56.155307Z node 11 :PERSQUEUE DEBUG: partition_init.cpp:86: [topic-f1:0:Initializer] Start initializing step TInitFieldsStep
2025-12-04T15:16:56.155315Z node 11 :PERSQUEUE DEBUG: partition_init.cpp:66: [topic-f1:0:Initializer] Initializing completed.
2025-12-04T15:16:56.155320Z node 11 :PERSQUEUE INFO: partition.cpp:707: [72075186224037892][Partition][0][StateInit] init complete for topic 'topic-f1' partition 0 generation 1 [11:7580022064045040620:2438]
2025-12-04T15:16:56.155328Z node 11 :PERSQUEUE DEBUG: partition.cpp:727: [72075186224037892][Partition][0][StateInit] SYNC INIT topic topic-f1 partitition 0 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-12-04T15:16:56.155335Z node 11 :PERSQUEUE DEBUG: partition_mlp.cpp:107: [72075186224037892][Partition][0][StateIdle] Initializing MLP Consumers: 0
2025-12-04T15:16:56.155405Z node 11 :PERSQUEUE DEBUG: partition.cpp:4404: [72075186224037892][Partition][0][StateIdle] Process pending events. Count 1
2025-12-04T15:16:56.155416Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.155421Z node 11 :PERSQUEUE DEBUG: partition.cpp:2392: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TTransaction[ProposeConfig])
2025-12-04T15:16:56.155436Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-12-04T15:16:56.155442Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.155445Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-12-04T15:16:56.155447Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.155457Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.155459Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-12-04T15:16:56.155461Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.155463Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-12-04T15:16:56.155465Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.155474Z node 11 :PERSQUEUE DEBUG: partition_read.cpp:930: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 user user readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-12-04T15:16:56.155486Z node 11 :PERSQUEUE DEBUG: partition_mlp.cpp:70: [72075186224037892][Partition][0][StateIdle] Process MLP pending events. Count 0
2025-12-04T15:16:56.155564Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:3563: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-12-04T15:16:56.155596Z node 11 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-12-04T15:16:56.156102Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:1045: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-12-04T15:16:56.156138Z node 11 :PERSQUEUE DEBUG: partition.cpp:1420: [72075186224037892][Partition][0][StateIdle] Handle TEvPQ::TEvTxCommit Step 1764861416199, TxId 281474976720674
2025-12-04T15:16:56.156146Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.156148Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-12-04T15:16:56.156150Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.156154Z node 11 :PERSQUEUE DEBUG: partition.cpp:2456: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TTransaction[ProposeConfig])
2025-12-04T15:16:56.156175Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-12-04T15:16:56.156181Z node 11 :PERSQUEUE DEBUG: partition.cpp:2318: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-12-04T15:16:56.156183Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.156225Z node 11 :PERSQUEUE DEBUG: read.h:275: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-12-04T15:16:56.156768Z node 11 :PERSQUEUE DEBUG: partition.cpp:2129: [72075186224037892][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-12-04T15:16:56.156808Z node 11 :PERSQUEUE DEBUG: partition_mlp.cpp:107: [72075186224037892][Partition][0][StateIdle] Initializing MLP Consumers: 0
2025-12-04T15:16:56.156835Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:572: [72075186224037892][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-12-04T15:16:56.156845Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.156847Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.156849Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.156851Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.156852Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.156856Z node 11 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-12-04T15:16:56.156984Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:398: [PQ: 72075186224037892] Apply new config PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 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 } PartitionIds: 0 TopicName: "topic-f1" Version: 0 RequireAuthWrite: true RequireAuthRead: true FormatVersion: 0 Codecs { } TopicPath: "/Root/topic-f1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } AllPartitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } Consumers { Name: "user" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 } MonitoringProjectId: ""
2025-12-04T15:16:56.156999Z node 11 :PERSQUEUE NOTICE: pq_impl.cpp:913: [PQ: 72075186224037892] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-12-04T15:16:56.157041Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:3563: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-12-04T15:16:56.157620Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:1045: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-12-04T15:16:56.157651Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:3563: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-12-04T15:16:56.158175Z node 12 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:942: [72075186224037893][topic-f1] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037893
2025-12-04T15:16:56.158594Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:1045: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
===Query complete
Create topic result: 1 
Created writer (initially).
2025-12-04T15:16:56.167003Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:107: new grpc connection
2025-12-04T15:16:56.167021Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:141: new session created cookie 1
2025-12-04T15:16:56.167172Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId:  grpc read done: success: 1 data: init_request { topic: "/Root/topic-f1" message_group_id: "123" }
2025-12-04T15:16:56.167204Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:447: session request cookie: 1 topic: "/Root/topic-f1" message_group_id: "123" from ipv6:[::1]:60084
2025-12-04T15:16:56.167214Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:1538: write session:  cookie=1 sessionId= userAgent="pqv1 server" ip=ipv6:[::1]:60084 proto=v1  topic=/Root/topic-f1 durationSec=0
2025-12-04T15:16:56.167219Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:571: init check schema
2025-12-04T15:16:56.168153Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:632: session v1 cookie: 1 sessionId:  describe result for acl check
2025-12-04T15:16:56.168243Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__table_helper.h:62: TTableHelper SelectQuery: --!syntax_v1
DECLARE $Hash AS Uint64; DECLARE $Topic AS Utf8; DECLARE $SourceId AS Utf8;
SELECT Partition, CreateTime, AccessTime, SeqNo FROM `//Root/.metadata/TopicPartitionsMapping` WHERE Hash == $Hash AND Topic == $Topic AND ProducerId == $SourceId;
2025-12-04T15:16:56.168256Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__table_helper.h:63: TTableHelper UpdateQuery: --!syntax_v1
DECLARE $SourceId AS Utf8; DECLARE $Topic AS Utf8; DECLARE $Hash AS Uint64; DECLARE $Partition AS Uint32; DECLARE $CreateTime AS Uint64; DECLARE $AccessTime AS Uint64; DECLARE $SeqNo AS Uint64;
UPSERT INTO `//Root/.metadata/TopicPartitionsMapping` (Hash, Topic, ProducerId, CreateTime, AccessTime, Partition, SeqNo) VALUES ($Hash, $Topic, $SourceId, $CreateTime, $AccessTime, $Partition, $SeqNo);
2025-12-04T15:16:56.168264Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__table_helper.h:64: TTableHelper UpdateAccessTimeQuery: --!syntax_v1
DECLARE $SourceId AS Utf8; DECLARE $Topic AS Utf8; DECLARE $Hash AS Uint64; DECLARE $Partition AS Uint32; DECLARE $CreateTime AS Uint64; DECLARE $AccessTime AS Uint64;
UPDATE `//Root/.metadata/TopicPartitionsMapping` SET AccessTime = $AccessTime WHERE Hash = $Hash AND Topic = $Topic AND ProducerId = $SourceId AND Partition = $Partition;
2025-12-04T15:16:56.169655Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976720676:1, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:690)
2025-12-04T15:16:56.246639Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpModifyACL, opId: 281474976720679:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at ydb/core/tx/schemeshard/schemeshard__operation_modify_acl.cpp:101)
2025-12-04T15:16:56.255768Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.255785Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.255787Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.255789Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.255791Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.304902Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976720682:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:690)
2025-12-04T15:16:56.356141Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.356159Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.356161Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.356164Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.356169Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.371307Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterTable, opId: 281474976720685:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at ydb/core/tx/schemeshard/schemeshard__operation_alter_table.cpp:188)
2025-12-04T15:16:56.445473Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterTable, opId: 281474976720692:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at ydb/core/tx/schemeshard/schemeshard__operation_alter_table.cpp:188)
2025-12-04T15:16:56.456462Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.456477Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.456479Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.456483Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.456486Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.512869Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpModifyACL, opId: 281474976720695:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at ydb/core/tx/schemeshard/schemeshard__operation_modify_acl.cpp:101)
2025-12-04T15:16:56.556854Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.556870Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.556873Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.556877Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.556879Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.579779Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:111: TPartitionChooser [11:7580022064045040697:2451] (SourceId=123, PreferedPartition=(NULL)) StartKqpSession
2025-12-04T15:16:56.580435Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:142: TPartitionChooser [11:7580022064045040697:2451] (SourceId=123, PreferedPartition=(NULL)) Select from the table
2025-12-04T15:16:56.610926Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:174: TPartitionChooser [11:7580022064045040697:2451] (SourceId=123, PreferedPartition=(NULL)) Update the table
2025-12-04T15:16:56.630015Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:183: TPartitionChooser [11:7580022064045040697:2451] (SourceId=123, PreferedPartition=(NULL)) HandleUpdate PartitionPersisted=0 Status=SUCCESS
2025-12-04T15:16:56.630034Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:305: TPartitionChooser [11:7580022064045040697:2451] (SourceId=123, PreferedPartition=(NULL)) ReplyResult: Partition=0, SeqNo=(NULL)
2025-12-04T15:16:56.630038Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:268: TPartitionChooser [11:7580022064045040697:2451] (SourceId=123, PreferedPartition=(NULL)) Start idle
2025-12-04T15:16:56.630048Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:694: ProceedPartition. session cookie: 1 sessionId:  partition: 0 expectedGeneration: (NULL)
2025-12-04T15:16:56.630193Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:822: TPartitionWriter 72075186224037892 (partition=0) TEvClientConnected Status OK, TabletId: 72075186224037892, NodeId 11, Generation: 1
2025-12-04T15:16:56.630217Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037892] server connected, pipe [11:7580022064045041461:2451], now have 1 active actors on pipe
2025-12-04T15:16:56.630225Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.630233Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.630265Z node 11 :PERSQUEUE INFO: ownerinfo.cpp:30: new Cookie 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0 generated for partition 0 topic 'topic-f1' owner 123
2025-12-04T15:16:56.630283Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.630292Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:56.630298Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-12-04T15:16:56.630302Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.630306Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:56.630318Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-12-04T15:16:56.630325Z node 11 :PERSQUEUE DEBUG: partition.cpp:2318: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-12-04T15:16:56.630327Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.630346Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:37: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyOwnerOk. Partition: 0
2025-12-04T15:16:56.630369Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-12-04T15:16:56.630407Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.630413Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.630426Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-12-04T15:16:56.630454Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:871: session inited cookie: 1 partition: 0 MaxSeqNo: 0 sessionId: 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0
2025-12-04T15:16:56.631152Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-12-04T15:16:56.631214Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0 grpc read done: success: 1 data:  write_request[data omitted]
Writes done
2025-12-04T15:16:56.631253Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-12-04T15:16:56.631268Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-12-04T15:16:56.631278Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-12-04T15:16:56.631308Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631315Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-12-04T15:16:56.631322Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.631330Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-12-04T15:16:56.631335Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631337Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.631342Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631344Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.631354Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-12-04T15:16:56.631360Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-12-04T15:16:56.631364Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 1
2025-12-04T15:16:56.631371Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 1  requestId: <none> cookie: 2
2025-12-04T15:16:56.631379Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 2  requestId: <none> cookie: 3
2025-12-04T15:16:56.631383Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631384Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.631388Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.631388Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 3  requestId: <none> cookie: 4
2025-12-04T15:16:56.631396Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.631400Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.631405Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.631419Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-12-04T15:16:56.631429Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631440Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.631454Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2010: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 1 partNo : 0 messageNo: 4 size 83 offset: -1
2025-12-04T15:16:56.631460Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631463Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.631466Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2010: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 2 partNo : 0 messageNo: 5 size 83 offset: -1
2025-12-04T15:16:56.631470Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631472Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.631472Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-12-04T15:16:56.631475Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2010: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 3 partNo : 0 messageNo: 6 size 83 offset: -1
2025-12-04T15:16:56.631479Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631481Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.631485Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2010: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 4 partNo : 0 messageNo: 7 size 83 offset: -1
2025-12-04T15:16:56.631489Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631491Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.631498Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:636: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-12-04T15:16:56.631509Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.631511Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:56.631512Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-12-04T15:16:56.631520Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-12-04T15:16:56.631522Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.631525Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:56.631559Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1342: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 1 partNo 0
2025-12-04T15:16:56.631598Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-12-04T15:16:56.631613Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1446: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 1 partNo 0 FormedBlobsCount 0 NewHead: Offset 0 PartNo 0 PackedSize 154 count 1 nextOffset 1 batches 1
2025-12-04T15:16:56.631625Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-12-04T15:16:56.631625Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-12-04T15:16:56.631627Z node 11 :PERSQUEUE DEBUG: partition.cpp:2318: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-12-04T15:16:56.631629Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.631678Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1698: [72075186224037892][Partition][0][StateIdle] Add new write blob: topic 'topic-f1' partition 0 compactOffset 0,1 HeadOffset 0 endOffset 0 curOffset 1 d0000000000_00000000000000000000_00000_0000000001_00000? size 140 WTime 1764861416631
2025-12-04T15:16:56.631707Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-12-04T15:16:56.631710Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:636: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-12-04T15:16:56.631715Z node 11 :PERSQUEUE DEBUG: partition.cpp:2281: [72075186224037892][Partition][0][StateIdle] Writing. Can't process user action and tx events
2025-12-04T15:16:56.631717Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:636: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-12-04T15:16:56.631720Z node 11 :PERSQUEUE DEBUG: partition.cpp:2281: [72075186224037892][Partition][0][StateIdle] Writing. Can't process user action and tx events
2025-12-04T15:16:56.631722Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:636: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-12-04T15:16:56.631725Z node 11 :PERSQUEUE DEBUG: partition.cpp:2281: [72075186224037892][Partition][0][StateIdle] Writing. Can't process user action and tx events
2025-12-04T15:16:56.631730Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631732Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.631738Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631740Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.631747Z node 11 :PERSQUEUE DEBUG: read.h:275: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-12-04T15:16:56.631761Z node 11 :PERSQUEUE DEBUG: read.h:313: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough blob. Partition 0 offset 0 partNo 0 count 1 size 140
2025-12-04T15:16:56.631773Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 8  requestId: <none> cookie: 5
2025-12-04T15:16:56.631777Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-12-04T15:16:56.631792Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.631821Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 9  requestId: <none> cookie: 6
2025-12-04T15:16:56.631824Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 10  requestId: <none> cookie: 7
2025-12-04T15:16:56.631829Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-12-04T15:16:56.631846Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.631856Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.631865Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-12-04T15:16:56.631916Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-12-04T15:16:56.631950Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631958Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.631964Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2010: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 5 partNo : 0 messageNo: 11 size 83 offset: -1
2025-12-04T15:16:56.631969Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631971Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-12-04T15:16:56.631975Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.631979Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631980Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.631984Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2010: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 6 partNo : 0 messageNo: 13 size 83 offset: -1
2025-12-04T15:16:56.631988Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631991Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.631994Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2010: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 7 partNo : 0 messageNo: 14 size 83 offset: -1
2025-12-04T15:16:56.631998Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.631999Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.632004Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:636: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-12-04T15:16:56.632008Z node 11 :PERSQUEUE DEBUG: partition.cpp:2281: [72075186224037892][Partition][0][StateIdle] Writing. Can't process user action and tx events
2025-12-04T15:16:56.632011Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:636: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-12-04T15:16:56.632014Z node 11 :PERSQUEUE DEBUG: partition.cpp:2281: [72075186224037892][Partition][0][StateIdle] Writing. Can't process user action and tx events
2025-12-04T15:16:56.632016Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:636: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-12-04T15:16:56.632018Z node 11 :PERSQUEUE DEBUG: partition.cpp:2281: [72075186224037892][Partition][0][StateIdle] Writing. Can't process user action and tx events
2025-12-04T15:16:56.632034Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 12  requestId: <none> cookie: 8
2025-12-04T15:16:56.632042Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 15  requestId: <none> cookie: 9
2025-12-04T15:16:56.632050Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.632055Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.632056Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.632058Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.632063Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 16  requestId: <none> cookie: 10
2025-12-04T15:16:56.632068Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.632127Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.632137Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.632148Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2010: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 8 partNo : 0 messageNo: 17 size 83 offset: -1
2025-12-04T15:16:56.632157Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.632159Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.632163Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2010: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 9 partNo : 0 messageNo: 18 size 83 offset: -1
2025-12-04T15:16:56.632167Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.632169Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.632173Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2010: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 10 partNo : 0 messageNo: 19 size 83 offset: -1
2025-12-04T15:16:56.632178Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:636: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-12-04T15:16:56.632191Z node 11 :PERSQUEUE DEBUG: partition.cpp:2281: [72075186224037892][Partition][0][StateIdle] Writing. Can't process user action and tx events
2025-12-04T15:16:56.632198Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:636: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-12-04T15:16:56.632201Z node 11 :PERSQUEUE DEBUG: partition.cpp:2281: [72075186224037892][Partition][0][StateIdle] Writing. Can't process user action and tx events
2025-12-04T15:16:56.632203Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:636: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-12-04T15:16:56.632207Z node 11 :PERSQUEUE DEBUG: partition.cpp:2281: [72075186224037892][Partition][0][StateIdle] Writing. Can't process user action and tx events
2025-12-04T15:16:56.632736Z node 11 :PERSQUEUE DEBUG: cache_eviction.h:321: Caching head blob in L1. Partition 0 offset 0 count 1 size 140 actorID [11:7580022064045040584:2438]
2025-12-04T15:16:56.632764Z node 11 :PERSQUEUE DEBUG: partition.cpp:2129: [72075186224037892][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-12-04T15:16:56.632790Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:572: [72075186224037892][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 87 WriteNewSizeFromSupportivePartitions# 0
2025-12-04T15:16:56.632802Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:60: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-12-04T15:16:56.632809Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:365: [72075186224037892][Partition][0][StateIdle] Answering for message sourceid: '\000123', Topic: 'topic-f1', Partition: 0, SeqNo: 1, partNo: 0, Offset: 0 is stored on disk
2025-12-04T15:16:56.632795Z node 11 :PERSQUEUE DEBUG: pq_l2_cache.cpp:129: PQ Cache (L2). Adding blob. Tablet '72075186224037892' partition 0 offset 0 partno 0 count 1 parts 0 suffix '63' size 140
2025-12-04T15:16:56.632848Z node 11 :PERSQUEUE DEBUG: partition_read.cpp:930: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 user user readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-12-04T15:16:56.632858Z node 11 :PERSQUEUE DEBUG: partition_read.cpp:972: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 user user send read request for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 1 rrg 0
2025-12-04T15:16:56.632863Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.632868Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:56.632874Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:56.632881Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:56.632884Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:56.632887Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:56.632889Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:56.632891Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:56.632894Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:56.632897Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:56.632900Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 9, PendingWrites: 0
2025-12-04T15:16:56.632902Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.632906Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:56.632923Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1342: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 2 partNo 0
2025-12-04T15:16:56.632949Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1446: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 2 partNo 0 FormedBlobsCount 0 NewHead: Offset 1 PartNo 0 PackedSize 154 count 1 nextOffset 2 batches 1
2025-12-04T15:16:56.632959Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:56.632965Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1342: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 3 partNo 0
2025-12-04T15:16:56.632969Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1446: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 3 partNo 0 FormedBlobsCount 0 NewHead: Offset 1 PartNo 0 PackedSize 276 count 2 nextOffset 3 batches 1
2025-12-04T15:16:56.632977Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:56.632982Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1342: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 4 partNo 0
2025-12-04T15:16:56.632987Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1446: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 4 partNo 0 FormedBlobsCount 0 NewHead: Offset 1 PartNo 0 PackedSize 398 count 3 nextOffset 4 batches 1
2025-12-04T15:16:56.632998Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:56.633002Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1342: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 5 partNo 0
2025-12-04T15:16:56.633007Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1446: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 5 partNo 0 FormedBlobsCount 0 NewHead: Offset 1 PartNo 0 PackedSize 520 count 4 nextOffset 5 batches 1
2025-12-04T15:16:56.633010Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:56.633014Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1342: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 6 partNo 0
2025-12-04T15:16:56.633017Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1446: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 6 partNo 0 FormedBlobsCount 0 NewHead: Offset 1 PartNo 0 PackedSize 642 count 5 nextOffset 6 batches 1
2025-12-04T15:16:56.633020Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:56.633025Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1342: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 7 partNo 0
2025-12-04T15:16:56.633029Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1446: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 7 partNo 0 FormedBlobsCount 0 NewHead: Offset 1 PartNo 0 PackedSize 764 count 6 nextOffset 7 batches 1
2025-12-04T15:16:56.633032Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:56.633037Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1342: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 8 partNo 0
2025-12-04T15:16:56.633041Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1446: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 8 partNo 0 FormedBlobsCount 0 NewHead: Offset 1 PartNo 0 PackedSize 886 count 7 nextOffset 8 batches 1
2025-12-04T15:16:56.633044Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:56.633048Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1342: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 9 partNo 0
2025-12-04T15:16:56.633052Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1446: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 9 partNo 0 FormedBlobsCount 0 NewHead: Offset 1 PartNo 0 PackedSize 1008 count 8 nextOffset 9 batches 1
2025-12-04T15:16:56.633055Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:56.633059Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1342: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 10 partNo 0
2025-12-04T15:16:56.633063Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1446: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 10 partNo 0 FormedBlobsCount 0 NewHead: Offset 1 PartNo 0 PackedSize 1130 count 9 nextOffset 10 batches 1
2025-12-04T15:16:56.633065Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 9
2025-12-04T15:16:56.633067Z node 11 :PERSQUEUE DEBUG: partition.cpp:2318: [72075186224037892][Partition][0][StateIdle] Batch completed (9)
2025-12-04T15:16:56.633070Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.633126Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1698: [72075186224037892][Partition][0][StateIdle] Add new write blob: topic 'topic-f1' partition 0 compactOffset 1,9 HeadOffset 1 endOffset 1 curOffset 10 d0000000000_00000000000000000001_00000_0000000009_00000? size 917 WTime 1764861416633
2025-12-04T15:16:56.633159Z node 11 :PERSQUEUE DEBUG: partition_compaction.cpp:193: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-12-04T15:16:56.633170Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 4  requestId: <none> cookie: 1
2025-12-04T15:16:56.633190Z node 11 :PERSQUEUE DEBUG: read.h:275: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-12-04T15:16:56.633203Z node 11 :PERSQUEUE DEBUG: read.h:313: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough blob. Partition 0 offset 1 partNo 0 count 9 size 917
2025-12-04T15:16:56.633207Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.633248Z node 11 :PERSQUEUE DEBUG: partition_read.cpp:887: [72075186224037892][Partition][0][StateIdle] read cookie 3 Topic 'topic-f1' partition 0 user user offset 0 partno 0 count 1 size 1024000 endOffset 1 max time lag 0ms effective offset 0
2025-12-04T15:16:56.633267Z node 11 :PERSQUEUE DEBUG: partition_read.cpp:1112: [72075186224037892][Partition][0][StateIdle] read cookie 3 added 1 blobs, size 140 count 1 last offset 0, current partition end offset: 1
2025-12-04T15:16:56.633275Z node 11 :PERSQUEUE DEBUG: partition_read.cpp:1128: [72075186224037892][Partition][0][StateIdle] Reading cookie 3. Send blob request.
2025-12-04T15:16:56.633291Z node 11 :PERSQUEUE DEBUG: cache_eviction.h:497: Got data from cache. Partition 0 offset 0 partno 0 count 1 parts_count 0 source 1 size 140 accessed 0 times before, last time 2025-12-04T15:16:56.000000Z
2025-12-04T15:16:56.633306Z node 11 :PERSQUEUE DEBUG: read.h:126: [72075186224037892][PQCacheProxy]Reading cookie 3. All 1 blobs are from cache.
2025-12-04T15:16:56.633322Z node 11 :PERSQUEUE DEBUG: pq_l2_cache.cpp:201: PQ Cache (L2). Touched. Tablet '72075186224037892' partition 0 offset 0 partno 0 count 1 parts 0 suffix '63'
2025-12-04T15:16:56.633400Z node 11 :PERSQUEUE DEBUG: partition_read.cpp:576: FormAnswer for 1 blobs
2025-12-04T15:16:56.633428Z node 11 :PERSQUEUE DEBUG: partition_read.cpp:496: FormAnswer processing batch offset 0 totakecount 1 count 1 size 122 from pos 0 cbcount 1
2025-12-04T15:16:56.633444Z node 11 :PERSQUEUE DEBUG: partition_read.cpp:1022: Topic 'topic-f1' partition 0 user user readTimeStamp done, result 1764861416631 queuesize 0 startOffset 0
2025-12-04T15:16:56.634236Z node 11 :PERSQUEUE DEBUG: cache_eviction.h:321: Caching head blob in L1. Partition 0 offset 1 count 9 size 917 actorID [11:7580022064045040584:2438]
2025-12-04T15:16:56.634256Z node 11 :PERSQUEUE DEBUG: partition.cpp:2129: [72075186224037892][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-12-04T15:16:56.634275Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:572: [72075186224037892][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 783 WriteNewSizeFromSupportivePartitions# 0
2025-12-04T15:16:56.634282Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:60: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-12-04T15:16:56.634289Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:365: [72075186224037892][Partition][0][StateIdle] Answering for message sourceid: '\000123', Topic: 'topic-f1', Partition: 0, SeqNo: 2, partNo: 0, Offset: 1 is stored on disk
2025-12-04T15:16:56.634293Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:60: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-12-04T15:16:56.634297Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:365: [72075186224037892][Partition][0][StateIdle] Answering for message sourceid: '\000123', Topic: 'topic-f1', Partition: 0, SeqNo: 3, partNo: 0, Offset: 2 is stored on disk
2025-12-04T15:16:56.634299Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:60: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-12-04T15:16:56.634304Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:365: [72075186224037892][Partition][0][StateIdle] Answering for message sourceid: '\000123', Topic: 'topic-f1', Partition: 0, SeqNo: 4, partNo: 0, Offset: 3 is stored on disk
2025-12-04T15:16:56.634306Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:60: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-12-04T15:16:56.634314Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:365: [72075186224037892][Partition][0][StateIdle] Answering for message sourceid: '\000123', Topic: 'topic-f1', Partition: 0, SeqNo: 5, partNo: 0, Offset: 4 is stored on disk
2025-12-04T15:16:56.634317Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:60: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-12-04T15:16:56.634321Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:365: [72075186224037892][Partition][0][StateIdle] Answering for message sourceid: '\000123', Topic: 'topic-f1', Partition: 0, SeqNo: 6, partNo: 0, Offset: 5 is stored on disk
2025-12-04T15:16:56.634324Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:60: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-12-04T15:16:56.634329Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:365: [72075186224037892][Partition][0][StateIdle] Answering for message sourceid: '\000123', Topic: 'topic-f1', Partition: 0, SeqNo: 7, partNo: 0, Offset: 6 is stored on disk
2025-12-04T15:16:56.634332Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:60: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-12-04T15:16:56.634336Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:365: [72075186224037892][Partition][0][StateIdle] Answering for message sourceid: '\000123', Topic: 'topic-f1', Partition: 0, SeqNo: 8, partNo: 0, Offset: 7 is stored on disk
2025-12-04T15:16:56.634338Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:60: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-12-04T15:16:56.634345Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:365: [72075186224037892][Partition][0][StateIdle] Answering for message sourceid: '\000123', Topic: 'topic-f1', Partition: 0, SeqNo: 9, partNo: 0, Offset: 8 is stored on disk
2025-12-04T15:16:56.634348Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:60: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-12-04T15:16:56.634354Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:365: [72075186224037892][Partition][0][StateIdle] Answering for message sourceid: '\000123', Topic: 'topic-f1', Partition: 0, SeqNo: 10, partNo: 0, Offset: 9 is stored on disk
2025-12-04T15:16:56.634375Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.634378Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.634380Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.634382Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.634386Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.634391Z node 11 :PERSQUEUE DEBUG: partition_compaction.cpp:193: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-12-04T15:16:56.634401Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 5  requestId: <none> cookie: 2
2025-12-04T15:16:56.634419Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 6  requestId: <none> cookie: 3
2025-12-04T15:16:56.634423Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 7  requestId: <none> cookie: 4
2025-12-04T15:16:56.634427Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 11  requestId: <none> cookie: 5
2025-12-04T15:16:56.634432Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 13  requestId: <none> cookie: 6
2025-12-04T15:16:56.634432Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.634436Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 14  requestId: <none> cookie: 7
2025-12-04T15:16:56.634440Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 17  requestId: <none> cookie: 8
2025-12-04T15:16:56.634442Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.634445Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 18  requestId: <none> cookie: 9
2025-12-04T15:16:56.634446Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.634449Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 19  requestId: <none> cookie: 10
2025-12-04T15:16:56.634451Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.634455Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.634463Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.634467Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.634472Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.634476Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.634650Z node 11 :PERSQUEUE DEBUG: pq_l2_cache.cpp:129: PQ Cache (L2). Adding blob. Tablet '72075186224037892' partition 0 offset 1 partno 0 count 9 parts 0 suffix '63' size 917
2025-12-04T15:16:56.657457Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.657478Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.657481Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.657484Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.657488Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
Writer closed
2025-12-04T15:16:56.731819Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0 grpc read done: success: 0 data: 
2025-12-04T15:16:56.731836Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:256: session v1 cookie: 1 sessionId: 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0 grpc read failed
2025-12-04T15:16:56.731861Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:232: session v1 cookie: 1 sessionId: 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0 grpc closed
2025-12-04T15:16:56.731866Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:304: session v1 cookie: 1 sessionId: 123|5999c736-b980d49a-a3dfe69a-3dd2d9f9_0 is DEAD
2025-12-04T15:16:56.732138Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::TEvents::TEvPoison
2025-12-04T15:16:56.732203Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2745: [PQ: 72075186224037892] server disconnected, pipe [11:7580022064045041461:2451] destroyed
2025-12-04T15:16:56.732223Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:140: [72075186224037892][Partition][0][StateIdle] TPartition::DropOwner.
2025-12-04T15:16:56.732231Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.732233Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.732235Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.732246Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.732247Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.757533Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.757556Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.757559Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.757562Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.757564Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.760293Z node 11 :PQ_READ_PROXY DEBUG: grpc_pq_schema.cpp:207: new Alter topic request
2025-12-04T15:16:56.760692Z node 11 :TX_PROXY ERROR: schemereq.cpp:593: Actor# [11:7580022064045041500:3785] txid# 281474976720701, issues: { message: "Path does not exist" issue_code: 200200 severity: 1 }
Alter topic (/Root/PQ//Root/topic-f1) response: 0 <main>: Error: Path does not exist, code: 200200
2025-12-04T15:16:56.762086Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:107: new grpc connection
2025-12-04T15:16:56.762098Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:141: new session created cookie 2
2025-12-04T15:16:56.762212Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 2 sessionId:  grpc read done: success: 1 data: init_request { topic: "/Root/topic-f1" message_group_id: "123" }
2025-12-04T15:16:56.762234Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:447: session request cookie: 2 topic: "/Root/topic-f1" message_group_id: "123" from ipv6:[::1]:60084
2025-12-04T15:16:56.762237Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:1538: write session:  cookie=2 sessionId= userAgent="pqv1 server" ip=ipv6:[::1]:60084 proto=v1  topic=/Root/topic-f1 durationSec=0
2025-12-04T15:16:56.762241Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:571: init check schema
2025-12-04T15:16:56.762456Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:632: session v1 cookie: 2 sessionId:  describe result for acl check
2025-12-04T15:16:56.762486Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__table_helper.h:62: TTableHelper SelectQuery: --!syntax_v1
DECLARE $Hash AS Uint64; DECLARE $Topic AS Utf8; DECLARE $SourceId AS Utf8;
SELECT Partition, CreateTime, AccessTime, SeqNo FROM `//Root/.metadata/TopicPartitionsMapping` WHERE Hash == $Hash AND Topic == $Topic AND ProducerId == $SourceId;
2025-12-04T15:16:56.762492Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__table_helper.h:63: TTableHelper UpdateQuery: --!syntax_v1
DECLARE $SourceId AS Utf8; DECLARE $Topic AS Utf8; DECLARE $Hash AS Uint64; DECLARE $Partition AS Uint32; DECLARE $CreateTime AS Uint64; DECLARE $AccessTime AS Uint64; DECLARE $SeqNo AS Uint64;
UPSERT INTO `//Root/.metadata/TopicPartitionsMapping` (Hash, Topic, ProducerId, CreateTime, AccessTime, Partition, SeqNo) VALUES ($Hash, $Topic, $SourceId, $CreateTime, $AccessTime, $Partition, $SeqNo);
2025-12-04T15:16:56.762494Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__table_helper.h:64: TTableHelper UpdateAccessTimeQuery: --!syntax_v1
DECLARE $SourceId AS Utf8; DECLARE $Topic AS Utf8; DECLARE $Hash AS Uint64; DECLARE $Partition AS Uint32; DECLARE $CreateTime AS Uint64; DECLARE $AccessTime AS Uint64;
UPDATE `//Root/.metadata/TopicPartitionsMapping` SET AccessTime = $AccessTime WHERE Hash = $Hash AND Topic = $Topic AND ProducerId = $SourceId AND Partition = $Partition;
2025-12-04T15:16:56.762532Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:111: TPartitionChooser [11:7580022064045041517:2639] (SourceId=123, PreferedPartition=(NULL)) StartKqpSession
2025-12-04T15:16:56.763084Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:142: TPartitionChooser [11:7580022064045041517:2639] (SourceId=123, PreferedPartition=(NULL)) Select from the table
2025-12-04T15:16:56.765111Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:174: TPartitionChooser [11:7580022064045041517:2639] (SourceId=123, PreferedPartition=(NULL)) Update the table
2025-12-04T15:16:56.767739Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:183: TPartitionChooser [11:7580022064045041517:2639] (SourceId=123, PreferedPartition=(NULL)) HandleUpdate PartitionPersisted=0 Status=SUCCESS
2025-12-04T15:16:56.767751Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:305: TPartitionChooser [11:7580022064045041517:2639] (SourceId=123, PreferedPartition=(NULL)) ReplyResult: Partition=0, SeqNo=0
2025-12-04T15:16:56.767755Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:268: TPartitionChooser [11:7580022064045041517:2639] (SourceId=123, PreferedPartition=(NULL)) Start idle
2025-12-04T15:16:56.767761Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:694: ProceedPartition. session cookie: 2 sessionId:  partition: 0 expectedGeneration: (NULL)
2025-12-04T15:16:56.767877Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:822: TPartitionWriter 72075186224037892 (partition=0) TEvClientConnected Status OK, TabletId: 72075186224037892, NodeId 11, Generation: 1
2025-12-04T15:16:56.767894Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037892] server connected, pipe [11:7580022064045041549:2639], now have 1 active actors on pipe
2025-12-04T15:16:56.767903Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.767909Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.767933Z node 11 :PERSQUEUE INFO: ownerinfo.cpp:30: new Cookie 123|d2ef3b81-ee3312bf-fadcbf87-92f7d2cc_0 generated for partition 0 topic 'topic-f1' owner 123
2025-12-04T15:16:56.767944Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.767948Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:56.767952Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-12-04T15:16:56.767954Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.767957Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:56.767967Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-12-04T15:16:56.767972Z node 11 :PERSQUEUE DEBUG: partition.cpp:2318: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-12-04T15:16:56.767976Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.768003Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:37: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyOwnerOk. Partition: 0
2025-12-04T15:16:56.768020Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-12-04T15:16:56.768045Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.768049Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.768060Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-12-04T15:16:56.768077Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:871: session inited cookie: 2 partition: 0 MaxSeqNo: 10 sessionId: 123|d2ef3b81-ee3312bf-fadcbf87-92f7d2cc_0
2025-12-04T15:16:56.768646Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 2 sessionId: 123|d2ef3b81-ee3312bf-fadcbf87-92f7d2cc_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-12-04T15:16:56.768754Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-12-04T15:16:56.768788Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.768793Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.768811Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 1
2025-12-04T15:16:56.768824Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.768858Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.768865Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.768879Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2010: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 11 partNo : 0 messageNo: 1 size 80 offset: -1
2025-12-04T15:16:56.768886Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:636: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-12-04T15:16:56.768906Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.768912Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:56.768920Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-12-04T15:16:56.768922Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.768925Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:56.768958Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1342: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 11 partNo 0
2025-12-04T15:16:56.769028Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1446: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 11 partNo 0 FormedBlobsCount 0 NewHead: Offset 10 PartNo 0 PackedSize 151 count 1 nextOffset 11 batches 1
2025-12-04T15:16:56.769040Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-12-04T15:16:56.769042Z node 11 :PERSQUEUE DEBUG: partition.cpp:2318: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-12-04T15:16:56.769044Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.769099Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1698: [72075186224037892][Partition][0][StateIdle] Add new write blob: topic 'topic-f1' partition 0 compactOffset 10,1 HeadOffset 10 endOffset 10 curOffset 11 d0000000000_00000000000000000010_00000_0000000001_00000? size 137 WTime 1764861416768
2025-12-04T15:16:56.769136Z node 11 :PERSQUEUE DEBUG: read.h:275: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-12-04T15:16:56.769146Z node 11 :PERSQUEUE DEBUG: read.h:313: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough blob. Partition 0 offset 10 partNo 0 count 1 size 137
2025-12-04T15:16:56.769860Z node 11 :PERSQUEUE DEBUG: cache_eviction.h:321: Caching head blob in L1. Partition 0 offset 10 count 1 size 137 actorID [11:7580022064045040584:2438]
2025-12-04T15:16:56.769881Z node 11 :PERSQUEUE DEBUG: partition.cpp:2129: [72075186224037892][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-12-04T15:16:56.769899Z node 11 :PERSQUEUE DEBUG: pq_l2_cache.cpp:129: PQ Cache (L2). Adding blob. Tablet '72075186224037892' partition 0 offset 10 partno 0 count 1 parts 0 suffix '63' size 137
2025-12-04T15:16:56.769901Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:572: [72075186224037892][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 84 WriteNewSizeFromSupportivePartitions# 0
2025-12-04T15:16:56.769910Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:60: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-12-04T15:16:56.769917Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:365: [72075186224037892][Partition][0][StateIdle] Answering for message sourceid: '\000123', Topic: 'topic-f1', Partition: 0, SeqNo: 11, partNo: 0, Offset: 10 is stored on disk
2025-12-04T15:16:56.769941Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.769948Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.769951Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.769953Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.769955Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.769962Z node 11 :PERSQUEUE DEBUG: partition_compaction.cpp:193: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-12-04T15:16:56.769969Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 1  requestId: <none> cookie: 1
2025-12-04T15:16:56.769988Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.857902Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.857921Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.857923Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.857927Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.857930Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.869076Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 2 sessionId: 123|d2ef3b81-ee3312bf-fadcbf87-92f7d2cc_0 grpc read done: success: 0 data: 
2025-12-04T15:16:56.869092Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:256: session v1 cookie: 2 sessionId: 123|d2ef3b81-ee3312bf-fadcbf87-92f7d2cc_0 grpc read failed
2025-12-04T15:16:56.869101Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:232: session v1 cookie: 2 sessionId: 123|d2ef3b81-ee3312bf-fadcbf87-92f7d2cc_0 grpc closed
2025-12-04T15:16:56.869106Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:304: session v1 cookie: 2 sessionId: 123|d2ef3b81-ee3312bf-fadcbf87-92f7d2cc_0 is DEAD
2025-12-04T15:16:56.869434Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::TEvents::TEvPoison
2025-12-04T15:16:56.869482Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2745: [PQ: 72075186224037892] server disconnected, pipe [11:7580022064045041549:2639] destroyed
2025-12-04T15:16:56.869495Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:140: [72075186224037892][Partition][0][StateIdle] TPartition::DropOwner.
2025-12-04T15:16:56.869510Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.869519Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.869521Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.869524Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.869526Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.900729Z node 11 :PQ_READ_PROXY DEBUG: grpc_pq_schema.cpp:207: new Alter topic request
2025-12-04T15:16:56.901031Z node 11 :TX_PROXY ERROR: schemereq.cpp:593: Actor# [11:7580022064045041585:3817] txid# 281474976720705, issues: { message: "Path does not exist" issue_code: 200200 severity: 1 }
Alter topic (/Root/PQ//Root/topic-f1) response: 0 <main>: Error: Path does not exist, code: 200200
2025-12-04T15:16:56.902456Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:107: new grpc connection
2025-12-04T15:16:56.902468Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:141: new session created cookie 3
2025-12-04T15:16:56.902621Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 3 sessionId:  grpc read done: success: 1 data: init_request { topic: "/Root/topic-f1" message_group_id: "123" }
2025-12-04T15:16:56.902642Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:447: session request cookie: 3 topic: "/Root/topic-f1" message_group_id: "123" from ipv6:[::1]:60084
2025-12-04T15:16:56.902649Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:1538: write session:  cookie=3 sessionId= userAgent="pqv1 server" ip=ipv6:[::1]:60084 proto=v1  topic=/Root/topic-f1 durationSec=0
2025-12-04T15:16:56.902652Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:571: init check schema
2025-12-04T15:16:56.902917Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:632: session v1 cookie: 3 sessionId:  describe result for acl check
2025-12-04T15:16:56.902966Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__table_helper.h:62: TTableHelper SelectQuery: --!syntax_v1
DECLARE $Hash AS Uint64; DECLARE $Topic AS Utf8; DECLARE $SourceId AS Utf8;
SELECT Partition, CreateTime, AccessTime, SeqNo FROM `//Root/.metadata/TopicPartitionsMapping` WHERE Hash == $Hash AND Topic == $Topic AND ProducerId == $SourceId;
2025-12-04T15:16:56.902972Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__table_helper.h:63: TTableHelper UpdateQuery: --!syntax_v1
DECLARE $SourceId AS Utf8; DECLARE $Topic AS Utf8; DECLARE $Hash AS Uint64; DECLARE $Partition AS Uint32; DECLARE $CreateTime AS Uint64; DECLARE $AccessTime AS Uint64; DECLARE $SeqNo AS Uint64;
UPSERT INTO `//Root/.metadata/TopicPartitionsMapping` (Hash, Topic, ProducerId, CreateTime, AccessTime, Partition, SeqNo) VALUES ($Hash, $Topic, $SourceId, $CreateTime, $AccessTime, $Partition, $SeqNo);
2025-12-04T15:16:56.902975Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__table_helper.h:64: TTableHelper UpdateAccessTimeQuery: --!syntax_v1
DECLARE $SourceId AS Utf8; DECLARE $Topic AS Utf8; DECLARE $Hash AS Uint64; DECLARE $Partition AS Uint32; DECLARE $CreateTime AS Uint64; DECLARE $AccessTime AS Uint64;
UPDATE `//Root/.metadata/TopicPartitionsMapping` SET AccessTime = $AccessTime WHERE Hash = $Hash AND Topic = $Topic AND ProducerId = $SourceId AND Partition = $Partition;
2025-12-04T15:16:56.903007Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:111: TPartitionChooser [11:7580022064045041595:2660] (SourceId=123, PreferedPartition=(NULL)) StartKqpSession
2025-12-04T15:16:56.903500Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:142: TPartitionChooser [11:7580022064045041595:2660] (SourceId=123, PreferedPartition=(NULL)) Select from the table
2025-12-04T15:16:56.905394Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:174: TPartitionChooser [11:7580022064045041595:2660] (SourceId=123, PreferedPartition=(NULL)) Update the table
2025-12-04T15:16:56.908563Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:183: TPartitionChooser [11:7580022064045041595:2660] (SourceId=123, PreferedPartition=(NULL)) HandleUpdate PartitionPersisted=0 Status=SUCCESS
2025-12-04T15:16:56.908580Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:305: TPartitionChooser [11:7580022064045041595:2660] (SourceId=123, PreferedPartition=(NULL)) ReplyResult: Partition=0, SeqNo=0
2025-12-04T15:16:56.908584Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:268: TPartitionChooser [11:7580022064045041595:2660] (SourceId=123, PreferedPartition=(NULL)) Start idle
2025-12-04T15:16:56.908592Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:694: ProceedPartition. session cookie: 3 sessionId:  partition: 0 expectedGeneration: (NULL)
2025-12-04T15:16:56.908767Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:822: TPartitionWriter 72075186224037892 (partition=0) TEvClientConnected Status OK, TabletId: 72075186224037892, NodeId 11, Generation: 1
2025-12-04T15:16:56.908775Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037892] server connected, pipe [11:7580022064045041627:2660], now have 1 active actors on pipe
2025-12-04T15:16:56.908783Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.908791Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.908833Z node 11 :PERSQUEUE INFO: ownerinfo.cpp:30: new Cookie 123|6e6d95b2-6d9a4fd6-1bcb80fe-e70bd18a_0 generated for partition 0 topic 'topic-f1' owner 123
2025-12-04T15:16:56.908848Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.908854Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:56.908861Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-12-04T15:16:56.908874Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.908881Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:56.908893Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-12-04T15:16:56.908899Z node 11 :PERSQUEUE DEBUG: partition.cpp:2318: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-12-04T15:16:56.908902Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.908919Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:37: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyOwnerOk. Partition: 0
2025-12-04T15:16:56.908939Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-12-04T15:16:56.908990Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.909001Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.909031Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-12-04T15:16:56.909077Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:871: session inited cookie: 3 partition: 0 MaxSeqNo: 11 sessionId: 123|6e6d95b2-6d9a4fd6-1bcb80fe-e70bd18a_0
2025-12-04T15:16:56.909679Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 3 sessionId: 123|6e6d95b2-6d9a4fd6-1bcb80fe-e70bd18a_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-12-04T15:16:56.909788Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-12-04T15:16:56.909829Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.909839Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.909857Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 1
2025-12-04T15:16:56.909871Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.909913Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:56.909923Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:56.909937Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2010: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 12 partNo : 0 messageNo: 1 size 80 offset: -1
2025-12-04T15:16:56.909947Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:636: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-12-04T15:16:56.909958Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.909965Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:56.909974Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-12-04T15:16:56.909977Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.909980Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:56.910013Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1342: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 12 partNo 0
2025-12-04T15:16:56.910059Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1446: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 12 partNo 0 FormedBlobsCount 0 NewHead: Offset 11 PartNo 0 PackedSize 151 count 1 nextOffset 12 batches 1
2025-12-04T15:16:56.910071Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-12-04T15:16:56.910073Z node 11 :PERSQUEUE DEBUG: partition.cpp:2318: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-12-04T15:16:56.910076Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.910125Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1698: [72075186224037892][Partition][0][StateIdle] Add new write blob: topic 'topic-f1' partition 0 compactOffset 11,1 HeadOffset 11 endOffset 11 curOffset 12 d0000000000_00000000000000000011_00000_0000000001_00000? size 137 WTime 1764861416910
2025-12-04T15:16:56.910173Z node 11 :PERSQUEUE DEBUG: read.h:275: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-12-04T15:16:56.910190Z node 11 :PERSQUEUE DEBUG: read.h:313: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough blob. Partition 0 offset 11 partNo 0 count 1 size 137
2025-12-04T15:16:56.910986Z node 11 :PERSQUEUE DEBUG: cache_eviction.h:321: Caching head blob in L1. Partition 0 offset 11 count 1 size 137 actorID [11:7580022064045040584:2438]
2025-12-04T15:16:56.911009Z node 11 :PERSQUEUE DEBUG: partition.cpp:2129: [72075186224037892][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-12-04T15:16:56.911027Z node 11 :PERSQUEUE DEBUG: pq_l2_cache.cpp:129: PQ Cache (L2). Adding blob. Tablet '72075186224037892' partition 0 offset 11 partno 0 count 1 parts 0 suffix '63' size 137
2025-12-04T15:16:56.911029Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:572: [72075186224037892][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 84 WriteNewSizeFromSupportivePartitions# 0
2025-12-04T15:16:56.911037Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:60: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-12-04T15:16:56.911045Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:365: [72075186224037892][Partition][0][StateIdle] Answering for message sourceid: '\000123', Topic: 'topic-f1', Partition: 0, SeqNo: 12, partNo: 0, Offset: 11 is stored on disk
2025-12-04T15:16:56.911070Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.911077Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.911079Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.911081Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.911083Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:56.911090Z node 11 :PERSQUEUE DEBUG: partition_compaction.cpp:193: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-12-04T15:16:56.911098Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 1  requestId: <none> cookie: 1
2025-12-04T15:16:56.911117Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:56.958241Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:56.958259Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.958262Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:56.958267Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:56.958270Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:57.010067Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 3 sessionId: 123|6e6d95b2-6d9a4fd6-1bcb80fe-e70bd18a_0 grpc read done: success: 0 data: 
2025-12-04T15:16:57.010088Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:256: session v1 cookie: 3 sessionId: 123|6e6d95b2-6d9a4fd6-1bcb80fe-e70bd18a_0 grpc read failed
2025-12-04T15:16:57.010099Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:232: session v1 cookie: 3 sessionId: 123|6e6d95b2-6d9a4fd6-1bcb80fe-e70bd18a_0 grpc closed
2025-12-04T15:16:57.010103Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:304: session v1 cookie: 3 sessionId: 123|6e6d95b2-6d9a4fd6-1bcb80fe-e70bd18a_0 is DEAD
2025-12-04T15:16:57.010302Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::TEvents::TEvPoison
2025-12-04T15:16:57.010380Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2745: [PQ: 72075186224037892] server disconnected, pipe [11:7580022064045041627:2660] destroyed
2025-12-04T15:16:57.010401Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:140: [72075186224037892][Partition][0][StateIdle] TPartition::DropOwner.
2025-12-04T15:16:57.010408Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:57.010412Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.010414Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:57.010417Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.010419Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:57.037142Z node 11 :PQ_READ_PROXY DEBUG: grpc_pq_schema.cpp:207: new Alter topic request
2025-12-04T15:16:57.037436Z node 11 :TX_PROXY ERROR: schemereq.cpp:593: Actor# [11:7580022068340008957:3847] txid# 281474976720709, issues: { message: "Path does not exist" issue_code: 200200 severity: 1 }
Alter topic (/Root/PQ//Root/topic-f1) response: 0 <main>: Error: Path does not exist, code: 200200
2025-12-04T15:16:57.039604Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:107: new grpc connection
2025-12-04T15:16:57.039619Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:141: new session created cookie 4
2025-12-04T15:16:57.039913Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 4 sessionId:  grpc read done: success: 1 data: init_request { topic: "/Root/topic-f1" message_group_id: "123" }
2025-12-04T15:16:57.039949Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:447: session request cookie: 4 topic: "/Root/topic-f1" message_group_id: "123" from ipv6:[::1]:60084
2025-12-04T15:16:57.039958Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:1538: write session:  cookie=4 sessionId= userAgent="pqv1 server" ip=ipv6:[::1]:60084 proto=v1  topic=/Root/topic-f1 durationSec=0
2025-12-04T15:16:57.039962Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:571: init check schema
2025-12-04T15:16:57.040235Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:632: session v1 cookie: 4 sessionId:  describe result for acl check
2025-12-04T15:16:57.040276Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__table_helper.h:62: TTableHelper SelectQuery: --!syntax_v1
DECLARE $Hash AS Uint64; DECLARE $Topic AS Utf8; DECLARE $SourceId AS Utf8;
SELECT Partition, CreateTime, AccessTime, SeqNo FROM `//Root/.metadata/TopicPartitionsMapping` WHERE Hash == $Hash AND Topic == $Topic AND ProducerId == $SourceId;
2025-12-04T15:16:57.040282Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__table_helper.h:63: TTableHelper UpdateQuery: --!syntax_v1
DECLARE $SourceId AS Utf8; DECLARE $Topic AS Utf8; DECLARE $Hash AS Uint64; DECLARE $Partition AS Uint32; DECLARE $CreateTime AS Uint64; DECLARE $AccessTime AS Uint64; DECLARE $SeqNo AS Uint64;
UPSERT INTO `//Root/.metadata/TopicPartitionsMapping` (Hash, Topic, ProducerId, CreateTime, AccessTime, Partition, SeqNo) VALUES ($Hash, $Topic, $SourceId, $CreateTime, $AccessTime, $Partition, $SeqNo);
2025-12-04T15:16:57.040287Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__table_helper.h:64: TTableHelper UpdateAccessTimeQuery: --!syntax_v1
DECLARE $SourceId AS Utf8; DECLARE $Topic AS Utf8; DECLARE $Hash AS Uint64; DECLARE $Partition AS Uint32; DECLARE $CreateTime AS Uint64; DECLARE $AccessTime AS Uint64;
UPDATE `//Root/.metadata/TopicPartitionsMapping` SET AccessTime = $AccessTime WHERE Hash = $Hash AND Topic = $Topic AND ProducerId = $SourceId AND Partition = $Partition;
2025-12-04T15:16:57.040325Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:111: TPartitionChooser [11:7580022068340008967:2680] (SourceId=123, PreferedPartition=(NULL)) StartKqpSession
2025-12-04T15:16:57.040938Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:142: TPartitionChooser [11:7580022068340008967:2680] (SourceId=123, PreferedPartition=(NULL)) Select from the table
2025-12-04T15:16:57.043191Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:174: TPartitionChooser [11:7580022068340008967:2680] (SourceId=123, PreferedPartition=(NULL)) Update the table
2025-12-04T15:16:57.046145Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:183: TPartitionChooser [11:7580022068340008967:2680] (SourceId=123, PreferedPartition=(NULL)) HandleUpdate PartitionPersisted=0 Status=SUCCESS
2025-12-04T15:16:57.046158Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:305: TPartitionChooser [11:7580022068340008967:2680] (SourceId=123, PreferedPartition=(NULL)) ReplyResult: Partition=0, SeqNo=0
2025-12-04T15:16:57.046162Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:268: TPartitionChooser [11:7580022068340008967:2680] (SourceId=123, PreferedPartition=(NULL)) Start idle
2025-12-04T15:16:57.046170Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:694: ProceedPartition. session cookie: 4 sessionId:  partition: 0 expectedGeneration: (NULL)
2025-12-04T15:16:57.046329Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:822: TPartitionWriter 72075186224037892 (partition=0) TEvClientConnected Status OK, TabletId: 72075186224037892, NodeId 11, Generation: 1
2025-12-04T15:16:57.046348Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037892] server connected, pipe [11:7580022068340008999:2680], now have 1 active actors on pipe
2025-12-04T15:16:57.046363Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:57.046376Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:57.046410Z node 11 :PERSQUEUE INFO: ownerinfo.cpp:30: new Cookie 123|affd383b-b90d0831-c77fb207-ade514b0_0 generated for partition 0 topic 'topic-f1' owner 123
2025-12-04T15:16:57.046426Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:57.046431Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:57.046437Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-12-04T15:16:57.046439Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:57.046443Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:57.046454Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-12-04T15:16:57.046460Z node 11 :PERSQUEUE DEBUG: partition.cpp:2318: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-12-04T15:16:57.046462Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:57.046478Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:37: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyOwnerOk. Partition: 0
2025-12-04T15:16:57.046496Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-12-04T15:16:57.046558Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:57.046571Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:57.046592Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-12-04T15:16:57.046616Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:871: session inited cookie: 4 partition: 0 MaxSeqNo: 12 sessionId: 123|affd383b-b90d0831-c77fb207-ade514b0_0
2025-12-04T15:16:57.047199Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 4 sessionId: 123|affd383b-b90d0831-c77fb207-ade514b0_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-12-04T15:16:57.047259Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-12-04T15:16:57.047292Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:57.047299Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:57.047314Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 1
2025-12-04T15:16:57.047331Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:57.047358Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-12-04T15:16:57.047363Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-12-04T15:16:57.047372Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2010: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 13 partNo : 0 messageNo: 1 size 80 offset: -1
2025-12-04T15:16:57.047381Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:636: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-12-04T15:16:57.047392Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:57.047398Z node 11 :PERSQUEUE DEBUG: partition.cpp:2399: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-12-04T15:16:57.047404Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-12-04T15:16:57.047407Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:57.047409Z node 11 :PERSQUEUE DEBUG: partition.cpp:2463: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-12-04T15:16:57.047432Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1342: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 13 partNo 0
2025-12-04T15:16:57.047470Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1446: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 13 partNo 0 FormedBlobsCount 0 NewHead: Offset 12 PartNo 0 PackedSize 151 count 1 nextOffset 13 batches 1
2025-12-04T15:16:57.047478Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-12-04T15:16:57.047480Z node 11 :PERSQUEUE DEBUG: partition.cpp:2318: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-12-04T15:16:57.047481Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:57.047515Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:1698: [72075186224037892][Partition][0][StateIdle] Add new write blob: topic 'topic-f1' partition 0 compactOffset 12,1 HeadOffset 12 endOffset 12 curOffset 13 d0000000000_00000000000000000012_00000_0000000001_00000? size 137 WTime 1764861417047
2025-12-04T15:16:57.047541Z node 11 :PERSQUEUE DEBUG: read.h:275: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-12-04T15:16:57.047552Z node 11 :PERSQUEUE DEBUG: read.h:313: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough blob. Partition 0 offset 12 partNo 0 count 1 size 137
2025-12-04T15:16:57.048188Z node 11 :PERSQUEUE DEBUG: cache_eviction.h:321: Caching head blob in L1. Partition 0 offset 12 count 1 size 137 actorID [11:7580022064045040584:2438]
2025-12-04T15:16:57.048210Z node 11 :PERSQUEUE DEBUG: partition.cpp:2129: [72075186224037892][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-12-04T15:16:57.048232Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:572: [72075186224037892][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 84 WriteNewSizeFromSupportivePartitions# 0
2025-12-04T15:16:57.048240Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:60: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-12-04T15:16:57.048246Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:365: [72075186224037892][Partition][0][StateIdle] Answering for message sourceid: '\000123', Topic: 'topic-f1', Partition: 0, SeqNo: 13, partNo: 0, Offset: 12 is stored on disk
2025-12-04T15:16:57.048251Z node 11 :PERSQUEUE DEBUG: pq_l2_cache.cpp:129: PQ Cache (L2). Adding blob. Tablet '72075186224037892' partition 0 offset 12 partno 0 count 1 parts 0 suffix '63' size 137
2025-12-04T15:16:57.048269Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:57.048275Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.048277Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:57.048279Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.048281Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:57.048289Z node 11 :PERSQUEUE DEBUG: partition_compaction.cpp:193: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-12-04T15:16:57.048297Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 1  requestId: <none> cookie: 1
2025-12-04T15:16:57.048315Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::TEvPersQueue::TEvResponse
2025-12-04T15:16:57.058563Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:57.058578Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.058581Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:57.058584Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.058587Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:57.147636Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 4 sessionId: 123|affd383b-b90d0831-c77fb207-ade514b0_0 grpc read done: success: 0 data: 
2025-12-04T15:16:57.147648Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:256: session v1 cookie: 4 sessionId: 123|affd383b-b90d0831-c77fb207-ade514b0_0 grpc read failed
2025-12-04T15:16:57.147656Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:232: session v1 cookie: 4 sessionId: 123|affd383b-b90d0831-c77fb207-ade514b0_0 grpc closed
2025-12-04T15:16:57.147660Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:304: session v1 cookie: 4 sessionId: 123|affd383b-b90d0831-c77fb207-ade514b0_0 is DEAD
2025-12-04T15:16:57.147831Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::TEvents::TEvPoison
2025-12-04T15:16:57.147877Z node 11 :PERSQUEUE DEBUG: pq_impl.cpp:2745: [PQ: 72075186224037892] server disconnected, pipe [11:7580022068340008999:2680] destroyed
2025-12-04T15:16:57.147893Z node 11 :PERSQUEUE DEBUG: partition_write.cpp:140: [72075186224037892][Partition][0][StateIdle] TPartition::DropOwner.
2025-12-04T15:16:57.147903Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:57.147916Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.147923Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:57.147925Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.147927Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:57.171374Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:57.171392Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.171394Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:57.171396Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.171398Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:57.271582Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:57.271600Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.271603Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:57.271607Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.271609Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:57.371950Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:57.371968Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.371970Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:57.371974Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.371975Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
2025-12-04T15:16:57.472298Z node 11 :PERSQUEUE DEBUG: partition.cpp:2305: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-12-04T15:16:57.472316Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.472318Z node 11 :PERSQUEUE DEBUG: partition.cpp:2313: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-12-04T15:16:57.472322Z node 11 :PERSQUEUE DEBUG: partition.cpp:2364: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-12-04T15:16:57.472324Z node 11 :PERSQUEUE DEBUG: partition.cpp:2323: [72075186224037892][Partition][0][StateIdle] Try persist
