2025-10-15T15:39:27.610264Z node 11 :METADATA_PROVIDER WARN: log.cpp:841: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[11:7561473609230531926:2076];send_to=[0:7307199536658146131:7762515];
2025-10-15T15:39:27.610328Z 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-10-15T15:39:27.656686Z node 12 :METADATA_PROVIDER WARN: log.cpp:841: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[12:7561473610276509618:2152];send_to=[0:7307199536658146131:7762515];
2025-10-15T15:39:27.656794Z 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=scheme_cache_undelivered_message;
test_client.cpp: SetPath # /home/runner/.ya/build/build_root/w2kl/001fd4/r3tmp/tmp48wrgr/pdisk_1.dat
2025-10-15T15:39:27.717060Z node 12 :PQ_READ_PROXY DEBUG: caching_service.cpp:44: Direct read cache: : Created
2025-10-15T15:39:27.720545Z node 11 :PQ_READ_PROXY DEBUG: caching_service.cpp:44: Direct read cache: : Created
2025-10-15T15:39:27.728111Z 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-10-15T15:39:27.745032Z 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-10-15T15:39:27.913422Z node 11 :IMPORT WARN: schemeshard_import.cpp:307: Table profiles were not loaded
2025-10-15T15:39:27.929571Z 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-10-15T15:39:27.939179Z node 11 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(11, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-10-15T15:39:27.939280Z node 11 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(11, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-10-15T15:39:27.942702Z node 11 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(12, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-10-15T15:39:27.942791Z node 11 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(12, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-10-15T15:39:27.950650Z node 11 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(11, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-10-15T15:39:27.954154Z node 11 :HIVE WARN: hive_impl.cpp:811: HIVE#72057594037968897 Handle TEvInterconnect::TEvNodeConnected, NodeId 12 Cookie 12
2025-10-15T15:39:27.954965Z node 11 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(12, (0,0,0,0)) VolatileState: Connecting -> Connected
TServer::EnableGrpc on GrpcPort 6286, node 11
2025-10-15T15:39:28.038642Z 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-10-15T15:39:28.059511Z 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/w2kl/001fd4/r3tmp/yandexHGuEGO.tmp
2025-10-15T15:39:28.059545Z node 11 :NET_CLASSIFIER WARN: net_classifier.cpp:196: will try to initialize from file: /home/runner/.ya/build/build_root/w2kl/001fd4/r3tmp/yandexHGuEGO.tmp
2025-10-15T15:39:28.059710Z node 11 :NET_CLASSIFIER WARN: net_classifier.cpp:202: successfully initialized from file: /home/runner/.ya/build/build_root/w2kl/001fd4/r3tmp/yandexHGuEGO.tmp
2025-10-15T15:39:28.059865Z node 11 :NET_CLASSIFIER ERROR: net_classifier.cpp:228: got bad distributable configuration
2025-10-15T15:39:28.094972Z INFO: TTestServer started on Port 22894 GrpcPort 6286
TClient is connected to server localhost:22894
PQClient connected to localhost:6286
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-10-15T15:39:28.413932Z 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-10-15T15:39:28.418686Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 281474976710657:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_alter_subdomain.cpp:311)
waiting...
waiting...
2025-10-15T15:39:28.518370Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710659:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:684)
waiting...
2025-10-15T15:39:28.638533Z node 11 :TX_CONVEYOR ERROR: log.cpp:841: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
waiting...
waiting...
2025-10-15T15:39:28.685356Z node 12 :TX_CONVEYOR ERROR: log.cpp:841: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-10-15T15:39:32.326114Z node 11 :KQP_WORKLOAD_SERVICE WARN: scheme_actors.cpp:225: [WorkloadService] [TPoolFetcherActor] ActorId: [11:7561473630705369512: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-10-15T15:39:32.326221Z 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-10-15T15:39:32.326593Z node 11 :KQP_WORKLOAD_SERVICE WARN: scheme_actors.cpp:225: [WorkloadService] [TPoolFetcherActor] ActorId: [11:7561473630705369523:2332], 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-10-15T15:39:32.326635Z node 11 :KQP_WORKLOAD_SERVICE WARN: scheme_actors.cpp:225: [WorkloadService] [TPoolFetcherActor] ActorId: [11:7561473630705369525: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-10-15T15:39:32.326664Z 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-10-15T15:39:32.330745Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateResourcePool, opId: 281474976710662:3, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_resource_pool.cpp:179)
2025-10-15T15:39:32.362666Z node 11 :KQP_WORKLOAD_SERVICE WARN: helpers.h:73: [WorkloadService] [TPoolCreatorActor] ActorId: [11:7561473630705369528:2335], DatabaseId: /Root, PoolId: default, Scheduled retry for error: { <main>: Error: Transaction 281474976710662 completed, doublechecking }
2025-10-15T15:39:32.392257Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710663:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:684)
2025-10-15T15:39:32.435095Z node 11 :TX_PROXY ERROR: schemereq.cpp:590: Actor# [11:7561473630705369710:2818] txid# 281474976710664, 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)" severity: 1 }
2025-10-15T15:39:32.472974Z node 11 :KQP_COMPILE_ACTOR ERROR: kqp_compile_actor.cpp:570: Compilation failed, self: [11:7561473630705369725:2348], status: SCHEME_ERROR, issues: <main>: Error: Type annotation, code: 1030
    <main>:3:16: Error: At function: KiReadTable!
        <main>:3:16: Error: Cannot find table 'db.[/Root/PQ/Config/V2/Cluster]' because it does not exist or you do not have access permissions. Please check correctness of table path and user permissions., code: 2003
2025-10-15T15:39:32.473288Z node 11 :KQP_SESSION WARN: kqp_session_actor.cpp:2408: SessionId: ydb://session/3?node_id=11&id=YThmOWQ2OWItNDQ4YjU2NDMtNmM1OTViZWMtZmE0ZTk4OGE=, ActorId: [11:7561473630705369509:2328], ActorState: ExecuteState, TraceId: 01k7m8dk34c1p1dv4gy3rbh4mm, ReplyQueryCompileError, status SCHEME_ERROR remove tx with tx_id: 
2025-10-15T15:39:32.473755Z node 11 :PERSQUEUE_CLUSTER_TRACKER ERROR: cluster_tracker.cpp:167: failed to list clusters: { Response { QueryIssues { message: "Type annotation" issue_code: 1030 severity: 1 issues { position { row: 3 column: 16 } message: "At function: KiReadTable!" end_position { row: 3 column: 16 } severity: 1 issues { position { row: 3 column: 16 } message: "Cannot find table \'db.[/Root/PQ/Config/V2/Cluster]\' because it does not exist or you do not have access permissions. Please check correctness of table path and user permissions." end_position { row: 3 column: 16 } issue_code: 2003 severity: 1 } } } TxMeta { } } YdbStatus: SCHEME_ERROR ConsumedRu: 1 }
2025-10-15T15:39:32.506750Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710665:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:684)
2025-10-15T15:39:32.610420Z node 11 :METADATA_PROVIDER ERROR: log.cpp:841: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[11:7561473609230531926:2076];send_to=[0:7307199536658146131:7762515];
2025-10-15T15:39:32.610501Z 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;
2025-10-15T15:39:32.658215Z node 12 :METADATA_PROVIDER ERROR: log.cpp:841: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[12:7561473610276509618:2152];send_to=[0:7307199536658146131:7762515];
2025-10-15T15:39:32.658312Z 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=timeout;
2025-10-15T15:39:32.715314Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710666:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:684)
=== 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-10-15T15:39:33.074994Z node 11 :KQP_EXECUTER ERROR: kqp_planner.cpp:123: TxId: 281474976710667. Ctx: { TraceId: 01k7m8dkmt9ppaw1vpbgd21ec5, Database: , SessionId: ydb://session/3?node_id=11&id=OWRhYmM4MWMtNTczZDE4MWUtZjVlYWQ2YjUtZTIxZTgzZmM=, PoolId: default, DatabaseId: /Root}. Database not set, use /Root
=== CheckClustersList. Subcribe to ClusterTracker from [11:7561473635000337380:3097] 
=== 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-10-15T15:39:38.451588Z node 11 :PQ_READ_PROXY DEBUG: grpc_pq_schema.cpp:186: new Create topic request
2025-10-15T15:39:38.498675Z node 11 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1653: [72075186224037893][] pipe [11:7561473656475174197:3295] connected; active server actors: 1
2025-10-15T15:39:38.498988Z node 11 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer__balancing.cpp:1517: [72075186224037893][topic-f1] updating configuration. Deleted partitions []. Added partitions [0]
2025-10-15T15:39:38.499758Z node 11 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:940: [72075186224037893][topic-f1] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037893
2025-10-15T15:39:38.503783Z node 11 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:138: [72075186224037893][topic-f1] BALANCER INIT DONE for topic-f1: (0, 72075186224037892) 
2025-10-15T15:39:38.507972Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2957: [PQ: 72075186224037892] Handle TEvInterconnect::TEvNodeInfo
2025-10-15T15:39:38.511043Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2989: [PQ: 72075186224037892] Transactions request. From tx_00000000000000000000, To tx_18446744073709551615
2025-10-15T15:39:38.511342Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:784: [PQ: 72075186224037892] no config, start with empty partitions and default config
2025-10-15T15:39:38.511391Z node 12 :PERSQUEUE NOTICE: pq_impl.cpp:908: [PQ: 72075186224037892] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-10-15T15:39:38.511437Z node 12 :PERSQUEUE INFO: pq_impl.cpp:609: [PQ: 72075186224037892] doesn't have tx writes info
2025-10-15T15:39:38.511955Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2718: [PQ: 72075186224037892] server connected, pipe [11:7561473656475174234:2449], now have 1 active actors on pipe
2025-10-15T15:39:38.511986Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2718: [PQ: 72075186224037892] server connected, pipe [11:7561473656475174196:3294], now have 1 active actors on pipe
2025-10-15T15:39:38.512713Z node 11 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:402: [72075186224037893][topic-f1] TEvClientConnected TabletId 72075186224037892, NodeId 12, Generation 1
2025-10-15T15:39:38.513855Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:3567: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-15T15:39:38.518582Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:1040: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-15T15:39:38.526039Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2718: [PQ: 72075186224037892] server connected, pipe [11:7561473656475174260:3346], now have 1 active actors on pipe
2025-10-15T15:39:38.526769Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:3567: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-15T15:39:38.531009Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:1040: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-15T15:39:38.532047Z node 12 :PERSQUEUE DEBUG: partition_init.cpp:81: [topic-f1:0:Initializer] Start initializing step TInitConfigStep
2025-10-15T15:39:38.532109Z node 12 :PERSQUEUE DEBUG: partition.cpp:1281: [72075186224037892][Partition][0][StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-15T15:39:38.532464Z node 12 :PERSQUEUE DEBUG: partition_init.cpp:81: [topic-f1:0:Initializer] Start initializing step TInitInternalFieldsStep
2025-10-15T15:39:38.532797Z node 12 :PERSQUEUE INFO: partition_init.cpp:1095: [72075186224037892][Partition][0][StateInit] bootstrapping 0 [12:7561473657521150329:2323]
2025-10-15T15:39:38.534423Z node 12 :PERSQUEUE DEBUG: partition_init.cpp:81: [topic-f1:0:Initializer] Start initializing step TInitFieldsStep
2025-10-15T15:39:38.534448Z node 12 :PERSQUEUE DEBUG: partition_init.cpp:61: [topic-f1:0:Initializer] Initializing completed.
2025-10-15T15:39:38.534478Z node 12 :PERSQUEUE INFO: partition.cpp:698: [72075186224037892][Partition][0][StateInit] init complete for topic 'topic-f1' partition 0 generation 1 [12:7561473657521150329:2323]
2025-10-15T15:39:38.534512Z node 12 :PERSQUEUE DEBUG: partition.cpp:712: [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-10-15T15:39:38.535021Z node 12 :PERSQUEUE DEBUG: partition.cpp:4311: [72075186224037892][Partition][0][StateIdle] Process pending events. Count 1
2025-10-15T15:39:38.535061Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:38.535200Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:38.535214Z node 12 :PERSQUEUE DEBUG: partition.cpp:2340: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-10-15T15:39:38.535234Z node 12 :PERSQUEUE DEBUG: partition.cpp:2356: [72075186224037892][Partition][0][StateIdle] Still pending for come commits
2025-10-15T15:39:38.535249Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:38.535263Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:38.535291Z node 12 :PERSQUEUE DEBUG: partition.cpp:2356: [72075186224037892][Partition][0][StateIdle] Still pending for come commits
2025-10-15T15:39:38.535329Z node 12 :PERSQUEUE DEBUG: partition_read.cpp:911: [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-10-15T15:39:38.535664Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:3567: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-15T15:39:38.535767Z node 12 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-10-15T15:39:38.545581Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:1040: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-15T15:39:38.545784Z node 12 :PERSQUEUE DEBUG: partition.cpp:1385: [72075186224037892][Partition][0][StateIdle] Handle TEvPQ::TEvTxCommit Step 1760542778568, TxId 281474976710672
2025-10-15T15:39:38.545811Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:38.545825Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:38.546042Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:38.546314Z node 12 :PERSQUEUE DEBUG: read.h:275: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-10-15T15:39:38.550230Z node 12 :PERSQUEUE DEBUG: partition.cpp:2154: [72075186224037892][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-10-15T15:39:38.550656Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:574: [72075186224037892][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-15T15:39:38.550681Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:38.550694Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:38.550705Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:38.550754Z node 12 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-10-15T15:39:38.551270Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:395: [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-10-15T15:39:38.551366Z node 12 :PERSQUEUE NOTICE: pq_impl.cpp:908: [PQ: 72075186224037892] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-10-15T15:39:38.551687Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:3567: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-15T15:39:38.559889Z node 11 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:940: [72075186224037893][topic-f1] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037893
2025-10-15T15:39:38.565849Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:1040: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-15T15:39:38.565940Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:3567: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-15T15:39:38.570623Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:1040: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-15T15:39:38.597934Z node 11 :KQP_EXECUTER ERROR: kqp_planner.cpp:123: TxId: 281474976710673. Ctx: { TraceId: 01k7m8ds30cepkjwfvfe1737xs, Database: , SessionId: ydb://session/3?node_id=11&id=ZGYwZjNjZTAtZDY0NDM5NDItNTE2MmYxYmMtY2JjYmQ0MmE=, PoolId: default, DatabaseId: /Root}. Database not set, use /Root
2025-10-15T15:39:38.635689Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:38.635722Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:38.635747Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
===Query complete
Create topic result: 1 
Created writer (initially).
2025-10-15T15:39:38.705782Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:107: new grpc connection
2025-10-15T15:39:38.705816Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:141: new session created cookie 1
2025-10-15T15:39:38.709605Z 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-10-15T15:39:38.709757Z 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]:35324
2025-10-15T15:39:38.709784Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:1538: write session:  cookie=1 sessionId= userAgent="pqv1 server" ip=ipv6:[::1]:35324 proto=v1  topic=/Root/topic-f1 durationSec=0
2025-10-15T15:39:38.709796Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:571: init check schema
2025-10-15T15:39:38.714594Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:632: session v1 cookie: 1 sessionId:  describe result for acl check
2025-10-15T15:39:38.714777Z 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-10-15T15:39:38.714795Z 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-10-15T15:39:38.714805Z 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-10-15T15:39:38.719754Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710674:1, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:684)
2025-10-15T15:39:38.736097Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:38.736128Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:38.736142Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:38.840470Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:38.840502Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:38.840517Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:38.941897Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:38.941928Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:38.941940Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:39.045504Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:39.045542Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:39.045558Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:39.149209Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:39.149244Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:39.149258Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:39.249075Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:39.249127Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:39.249141Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:39.350741Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:39.350776Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:39.350790Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:39.455953Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:39.455983Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:39.455996Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:39.557183Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:39.557216Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:39.557228Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:39.630052Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpModifyACL, opId: 281474976710677:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_modify_acl.cpp:101)
2025-10-15T15:39:39.657227Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:39.657261Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:39.657278Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:39.761565Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:39.761605Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:39.761622Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:39.861526Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:39.861561Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:39.861575Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:39.962604Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:39.962637Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:39.962651Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:40.062623Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:40.062680Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:40.062692Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:40.165326Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:40.165366Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:40.165382Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:40.265414Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:40.265457Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:40.265473Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:40.370960Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:40.370991Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:40.371004Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:40.379984Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710683:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:684)
2025-10-15T15:39:40.471181Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:40.471210Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:40.471222Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:40.571516Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:40.571546Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:40.571559Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:40.671861Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:40.671888Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:40.671899Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:40.772684Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:40.772716Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:40.772730Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:40.877353Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:40.877388Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:40.877401Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:40.983449Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:40.983484Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:40.983498Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:41.022015Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterTable, opId: 281474976710686:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_alter_table.cpp:172)
2025-10-15T15:39:41.083882Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:41.083910Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:41.083931Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:41.184279Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:41.184315Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:41.184330Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:41.284746Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:41.284785Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:41.284800Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:41.385666Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:41.385694Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:41.385704Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:41.485484Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:41.485517Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:41.485537Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:41.589200Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:41.589234Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:41.589250Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:41.693176Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:41.693213Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:41.693225Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:41.703821Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterTable, opId: 281474976710692:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_alter_table.cpp:172)
2025-10-15T15:39:41.794046Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:41.794078Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:41.794090Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:41.894335Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:41.894368Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:41.894393Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:41.997208Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:41.997252Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:41.997266Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:42.101869Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:42.101921Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:42.101944Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:42.202540Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:42.202579Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:42.202592Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:42.305226Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:42.305259Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:42.305272Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:42.343318Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpModifyACL, opId: 281474976710695:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_modify_acl.cpp:101)
2025-10-15T15:39:42.407792Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:42.407819Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:42.407830Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:42.509182Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:42.509212Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:42.509226Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:42.613197Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:42.613235Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:42.613251Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:42.713799Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:42.713841Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:42.713853Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:42.814127Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:42.814161Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:42.814174Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:42.877596Z node 11 :FLAT_TX_SCHEMESHARD WARN: schemeshard_impl.cpp:7721: Cannot get console configs
2025-10-15T15:39:42.877630Z node 11 :IMPORT WARN: schemeshard_import.cpp:307: Table profiles were not loaded
2025-10-15T15:39:42.914804Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:42.914854Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:42.914878Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:43.017335Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:43.017371Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:43.017386Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:43.116303Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:43.116337Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:43.116351Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:43.129343Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:111: TPartitionChooser [11:7561473656475174343:2463] (SourceId=123, PreferedPartition=(NULL)) StartKqpSession
2025-10-15T15:39:43.134349Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:142: TPartitionChooser [11:7561473656475174343:2463] (SourceId=123, PreferedPartition=(NULL)) Select from the table
2025-10-15T15:39:43.218194Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:43.218226Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:43.218237Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:43.320332Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:43.320375Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:43.320386Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:43.358144Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:174: TPartitionChooser [11:7561473656475174343:2463] (SourceId=123, PreferedPartition=(NULL)) Update the table
2025-10-15T15:39:43.421340Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:43.421373Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:43.421389Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:43.503182Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:183: TPartitionChooser [11:7561473656475174343:2463] (SourceId=123, PreferedPartition=(NULL)) HandleUpdate PartitionPersisted=0 Status=SUCCESS
2025-10-15T15:39:43.503237Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:305: TPartitionChooser [11:7561473656475174343:2463] (SourceId=123, PreferedPartition=(NULL)) ReplyResult: Partition=0, SeqNo=(NULL)
2025-10-15T15:39:43.503260Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:268: TPartitionChooser [11:7561473656475174343:2463] (SourceId=123, PreferedPartition=(NULL)) Start idle
2025-10-15T15:39:43.503299Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:694: ProceedPartition. session cookie: 1 sessionId:  partition: 0 expectedGeneration: (NULL)
2025-10-15T15:39:43.506181Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2718: [PQ: 72075186224037892] server connected, pipe [11:7561473677950011815:2463], now have 1 active actors on pipe
2025-10-15T15:39:43.507530Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:822: TPartitionWriter 72075186224037892 (partition=0) TEvClientConnected Status OK, TabletId: 72075186224037892, NodeId 12, Generation: 1
2025-10-15T15:39:43.511599Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.511646Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.511756Z node 12 :PERSQUEUE INFO: ownerinfo.cpp:30: new Cookie 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0 generated for partition 0 topic 'topic-f1' owner 123
2025-10-15T15:39:43.511801Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:43.511824Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:43.511836Z node 12 :PERSQUEUE DEBUG: partition.cpp:2340: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-10-15T15:39:43.511890Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:43.511936Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:35: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyOwnerOk. Partition: 0
2025-10-15T15:39:43.511994Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-10-15T15:39:43.517582Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.517626Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.517722Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-10-15T15:39:43.518435Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:871: session inited cookie: 1 partition: 0 MaxSeqNo: 0 sessionId: 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0
2025-10-15T15:39:43.521703Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:43.521732Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:43.521744Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
Writes done
2025-10-15T15:39:43.524332Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-10-15T15:39:43.524609Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-10-15T15:39:43.525603Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-10-15T15:39:43.525792Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-10-15T15:39:43.526022Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-10-15T15:39:43.526037Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.526080Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.526132Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.526146Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.526237Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 1
2025-10-15T15:39:43.526279Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 1  requestId: <none> cookie: 2
2025-10-15T15:39:43.526252Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-10-15T15:39:43.526293Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-10-15T15:39:43.526474Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-10-15T15:39:43.526524Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.526628Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.526851Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-10-15T15:39:43.526989Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-10-15T15:39:43.527356Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.529586Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-10-15T15:39:43.529643Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.529905Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-10-15T15:39:43.529975Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.530259Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-10-15T15:39:43.530401Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-10-15T15:39:43.530601Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-10-15T15:39:43.530731Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-10-15T15:39:43.526975Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.527004Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.527076Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.527092Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.527118Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 2  requestId: <none> cookie: 3
2025-10-15T15:39:43.527179Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.527193Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.530965Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-10-15T15:39:43.527245Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2007: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 1 partNo : 0 messageNo: 4 size 83 offset: -1
2025-10-15T15:39:43.531109Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-10-15T15:39:43.527296Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.527309Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.527334Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2007: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 2 partNo : 0 messageNo: 5 size 83 offset: -1
2025-10-15T15:39:43.527406Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.527426Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.527452Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:637: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-10-15T15:39:43.527504Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:43.527537Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:43.527553Z node 12 :PERSQUEUE DEBUG: partition.cpp:2340: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-10-15T15:39:43.527667Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1319: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 1 partNo 0
2025-10-15T15:39:43.528544Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1423: [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-10-15T15:39:43.528588Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:43.529197Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1675: [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 1760542783526
2025-10-15T15:39:43.529350Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:637: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-10-15T15:39:43.529397Z node 12 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Writing. Can't process transactions and user actions
2025-10-15T15:39:43.529420Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 3  requestId: <none> cookie: 4
2025-10-15T15:39:43.529542Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.529563Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.529600Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2007: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 3 partNo : 0 messageNo: 7 size 83 offset: -1
2025-10-15T15:39:43.529634Z node 12 :PERSQUEUE DEBUG: read.h:275: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-10-15T15:39:43.529768Z node 12 :PERSQUEUE DEBUG: read.h:313: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough blob. Partition 0 offset 0 partNo 0 count 1 size 140
2025-10-15T15:39:43.529812Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 6  requestId: <none> cookie: 5
2025-10-15T15:39:43.529850Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:637: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-10-15T15:39:43.529873Z node 12 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Writing. Can't process transactions and user actions
2025-10-15T15:39:43.530075Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.531468Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-10-15T15:39:43.530095Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.531534Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.530132Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2007: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 4 partNo : 0 messageNo: 8 size 83 offset: -1
2025-10-15T15:39:43.531575Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.530510Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:637: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-10-15T15:39:43.530542Z node 12 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Writing. Can't process transactions and user actions
2025-10-15T15:39:43.531840Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-10-15T15:39:43.530581Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.530597Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.530642Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.530655Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.530693Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2007: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 5 partNo : 0 messageNo: 10 size 83 offset: -1
2025-10-15T15:39:43.530744Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.530762Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.530795Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:637: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-10-15T15:39:43.530812Z node 12 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Writing. Can't process transactions and user actions
2025-10-15T15:39:43.530868Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 9  requestId: <none> cookie: 6
2025-10-15T15:39:43.530893Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 11  requestId: <none> cookie: 7
2025-10-15T15:39:43.537279Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.537319Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.537373Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.537387Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.537432Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.537475Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.537519Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2007: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 6 partNo : 0 messageNo: 14 size 83 offset: -1
2025-10-15T15:39:43.537578Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.537593Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.537617Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2007: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 7 partNo : 0 messageNo: 15 size 83 offset: -1
2025-10-15T15:39:43.537661Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.537678Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.538085Z node 12 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-10-15T15:39:43.538137Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:637: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-10-15T15:39:43.538169Z node 12 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Writing. Can't process transactions and user actions
2025-10-15T15:39:43.538185Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:637: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-10-15T15:39:43.538201Z node 12 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Writing. Can't process transactions and user actions
2025-10-15T15:39:43.538258Z node 12 :PERSQUEUE DEBUG: cache_eviction.h:321: Caching head blob in L1. Partition 0 offset 0 count 1 size 140 actorID [12:7561473657521150312:2323]
2025-10-15T15:39:43.538376Z node 12 :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-10-15T15:39:43.541188Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.538503Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 12  requestId: <none> cookie: 8
2025-10-15T15:39:43.538537Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 13  requestId: <none> cookie: 9
2025-10-15T15:39:43.541302Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.538559Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 16  requestId: <none> cookie: 10
2025-10-15T15:39:43.541345Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.538583Z node 12 :PERSQUEUE DEBUG: partition.cpp:2154: [72075186224037892][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-10-15T15:39:43.538622Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:574: [72075186224037892][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 87 WriteNewSizeFromSupportivePartitions# 0
2025-10-15T15:39:43.538662Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:58: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-10-15T15:39:43.538699Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:361: [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-10-15T15:39:43.538917Z node 12 :PERSQUEUE DEBUG: partition_read.cpp:911: [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-10-15T15:39:43.538940Z node 12 :PERSQUEUE DEBUG: partition_read.cpp:953: [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-10-15T15:39:43.538961Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:43.539009Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:43.539031Z node 12 :PERSQUEUE DEBUG: partition.cpp:2340: [72075186224037892][Partition][0][StateIdle] Batch completed (6)
2025-10-15T15:39:43.539159Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1319: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 2 partNo 0
2025-10-15T15:39:43.655996Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1423: [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-10-15T15:39:43.656080Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1319: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 3 partNo 0
2025-10-15T15:39:43.656118Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1423: [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-10-15T15:39:43.656142Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1319: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 4 partNo 0
2025-10-15T15:39:43.656162Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1423: [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-10-15T15:39:43.656182Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1319: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 5 partNo 0
2025-10-15T15:39:43.656201Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1423: [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-10-15T15:39:43.656226Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1319: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 6 partNo 0
2025-10-15T15:39:43.656245Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1423: [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-10-15T15:39:43.656264Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1319: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 7 partNo 0
2025-10-15T15:39:43.656283Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1423: [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-10-15T15:39:43.656302Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:43.657076Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1675: [72075186224037892][Partition][0][StateIdle] Add new write blob: topic 'topic-f1' partition 0 compactOffset 1,6 HeadOffset 1 endOffset 1 curOffset 7 d0000000000_00000000000000000001_00000_0000000006_00000? size 641 WTime 1760542783654
2025-10-15T15:39:43.657398Z node 12 :PERSQUEUE DEBUG: partition_compaction.cpp:193: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-10-15T15:39:43.657490Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:1181: [PQ: 72075186224037892] Topic 'topic-f1' counters. CacheSize 140 CachedBlobs 1
2025-10-15T15:39:43.657538Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 4  requestId: <none> cookie: 1
2025-10-15T15:39:43.657678Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.657703Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.657749Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2007: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 8 partNo : 0 messageNo: 17 size 83 offset: -1
2025-10-15T15:39:43.657809Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.657824Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.657846Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2007: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 9 partNo : 0 messageNo: 18 size 83 offset: -1
2025-10-15T15:39:43.657885Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:43.657897Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:43.657920Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2007: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 10 partNo : 0 messageNo: 19 size 83 offset: -1
2025-10-15T15:39:43.657968Z node 12 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Writing. Can't process transactions and user actions
2025-10-15T15:39:43.657988Z node 12 :PERSQUEUE DEBUG: read.h:275: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-10-15T15:39:43.658120Z node 12 :PERSQUEUE DEBUG: read.h:313: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough blob. Partition 0 offset 1 partNo 0 count 6 size 641
2025-10-15T15:39:43.658205Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:637: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-10-15T15:39:43.658241Z node 12 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Writing. Can't process transactions and user actions
2025-10-15T15:39:43.658256Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:637: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-10-15T15:39:43.658271Z node 12 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Writing. Can't process transactions and user actions
2025-10-15T15:39:43.658283Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:637: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-10-15T15:39:43.658300Z node 12 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Writing. Can't process transactions and user actions
2025-10-15T15:39:43.658461Z node 12 :PERSQUEUE DEBUG: partition_read.cpp:868: [72075186224037892][Partition][0][StateIdle] read cookie 3 Topic 'topic-f1' partition 0 user user offset 0 count 1 size 1024000 endOffset 1 max time lag 0ms effective offset 0
2025-10-15T15:39:43.658458Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.658693Z node 12 :PERSQUEUE DEBUG: partition_read.cpp:1082: [72075186224037892][Partition][0][StateIdle] read cookie 3 added 1 blobs, size 140 count 1 last offset 0, current partition end offset: 1
2025-10-15T15:39:43.658720Z node 12 :PERSQUEUE DEBUG: partition_read.cpp:1108: [72075186224037892][Partition][0][StateIdle] Reading cookie 3. Send blob request.
2025-10-15T15:39:43.658793Z node 12 :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-10-15T15:39:43.000000Z
2025-10-15T15:39:43.658826Z node 12 :PERSQUEUE DEBUG: read.h:126: [72075186224037892][PQCacheProxy]Reading cookie 3. All 1 blobs are from cache.
2025-10-15T15:39:43.659245Z node 12 :PERSQUEUE DEBUG: partition_read.cpp:574: FormAnswer for 1 blobs
2025-10-15T15:39:43.659311Z node 12 :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-10-15T15:39:43.659394Z node 12 :PERSQUEUE DEBUG: partition_read.cpp:491: FormAnswer processing batch offset 0 totakecount 1 count 1 size 122 from pos 0 cbcount 1
2025-10-15T15:39:43.659467Z node 12 :PERSQUEUE DEBUG: partition_read.cpp:1003: Topic 'topic-f1' partition 0 user user readTimeStamp done, result 1760542783526 queuesize 0 startOffset 0
2025-10-15T15:39:43.663847Z node 12 :PERSQUEUE DEBUG: cache_eviction.h:321: Caching head blob in L1. Partition 0 offset 1 count 6 size 641 actorID [12:7561473657521150312:2323]
2025-10-15T15:39:43.663926Z node 12 :PERSQUEUE DEBUG: partition.cpp:2154: [72075186224037892][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-10-15T15:39:43.663974Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:574: [72075186224037892][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 522 WriteNewSizeFromSupportivePartitions# 0
2025-10-15T15:39:43.664011Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:58: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-10-15T15:39:43.664054Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:361: [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-10-15T15:39:43.664073Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:58: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-10-15T15:39:43.664096Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:361: [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-10-15T15:39:43.664111Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:58: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-10-15T15:39:43.664133Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:361: [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-10-15T15:39:43.664147Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:58: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-10-15T15:39:43.664183Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:361: [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-10-15T15:39:43.664201Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:58: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-10-15T15:39:43.664226Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:361: [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-10-15T15:39:43.664239Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:58: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-10-15T15:39:43.664264Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:361: [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-10-15T15:39:43.664475Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:43.664514Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:43.664524Z node 12 :PERSQUEUE DEBUG: partition.cpp:2340: [72075186224037892][Partition][0][StateIdle] Batch completed (3)
2025-10-15T15:39:43.664614Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1319: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 8 partNo 0
2025-10-15T15:39:43.665570Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1423: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 8 partNo 0 FormedBlobsCount 0 NewHead: Offset 7 PartNo 0 PackedSize 154 count 1 nextOffset 8 batches 1
2025-10-15T15:39:43.665614Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1319: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 9 partNo 0
2025-10-15T15:39:43.665647Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1423: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 9 partNo 0 FormedBlobsCount 0 NewHead: Offset 7 PartNo 0 PackedSize 276 count 2 nextOffset 9 batches 1
2025-10-15T15:39:43.665670Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1319: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 10 partNo 0
2025-10-15T15:39:43.665694Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1423: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob complete sourceId '\000123' seqNo 10 partNo 0 FormedBlobsCount 0 NewHead: Offset 7 PartNo 0 PackedSize 398 count 3 nextOffset 10 batches 1
2025-10-15T15:39:43.665710Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:43.666088Z node 12 :PERSQUEUE DEBUG: pq_l2_cache.cpp:129: PQ Cache (L2). Adding blob. Tablet '72075186224037892' partition 0 offset 1 partno 0 count 6 parts 0 suffix '63' size 641
2025-10-15T15:39:43.666184Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1675: [72075186224037892][Partition][0][StateIdle] Add new write blob: topic 'topic-f1' partition 0 compactOffset 7,3 HeadOffset 7 endOffset 7 curOffset 10 d0000000000_00000000000000000007_00000_0000000003_00000? size 365 WTime 1760542783665
2025-10-15T15:39:43.666303Z node 12 :PERSQUEUE DEBUG: partition_compaction.cpp:193: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-10-15T15:39:43.666360Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 5  requestId: <none> cookie: 2
2025-10-15T15:39:43.666415Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 7  requestId: <none> cookie: 3
2025-10-15T15:39:43.666442Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 8  requestId: <none> cookie: 4
2025-10-15T15:39:43.666468Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 10  requestId: <none> cookie: 5
2025-10-15T15:39:43.666493Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 14  requestId: <none> cookie: 6
2025-10-15T15:39:43.666516Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 15  requestId: <none> cookie: 7
2025-10-15T15:39:43.666544Z node 12 :PERSQUEUE DEBUG: read.h:275: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-10-15T15:39:43.666734Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.666677Z node 12 :PERSQUEUE DEBUG: read.h:313: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough blob. Partition 0 offset 7 partNo 0 count 3 size 365
2025-10-15T15:39:43.666802Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.666822Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.666872Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.666895Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.666916Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.670080Z node 12 :PERSQUEUE DEBUG: cache_eviction.h:321: Caching head blob in L1. Partition 0 offset 7 count 3 size 365 actorID [12:7561473657521150312:2323]
2025-10-15T15:39:43.670124Z node 12 :PERSQUEUE DEBUG: partition.cpp:2154: [72075186224037892][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-10-15T15:39:43.670156Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:574: [72075186224037892][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 261 WriteNewSizeFromSupportivePartitions# 0
2025-10-15T15:39:43.670180Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:58: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-10-15T15:39:43.670206Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:361: [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-10-15T15:39:43.670219Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:58: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-10-15T15:39:43.670234Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:361: [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-10-15T15:39:43.670244Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:58: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-10-15T15:39:43.670259Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:361: [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-10-15T15:39:43.670910Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.670982Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.671036Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:43.670404Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:43.670417Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:43.670425Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:43.670448Z node 12 :PERSQUEUE DEBUG: partition_compaction.cpp:193: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-10-15T15:39:43.670478Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 17  requestId: <none> cookie: 8
2025-10-15T15:39:43.670510Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 18  requestId: <none> cookie: 9
2025-10-15T15:39:43.670529Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 19  requestId: <none> cookie: 10
2025-10-15T15:39:43.670667Z node 12 :PERSQUEUE DEBUG: pq_l2_cache.cpp:129: PQ Cache (L2). Adding blob. Tablet '72075186224037892' partition 0 offset 7 partno 0 count 3 parts 0 suffix '63' size 365
Writer closed
2025-10-15T15:39:43.733437Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0 grpc read done: success: 0 data: 
2025-10-15T15:39:43.733472Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:256: session v1 cookie: 1 sessionId: 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0 grpc read failed
2025-10-15T15:39:43.733507Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:232: session v1 cookie: 1 sessionId: 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0 grpc closed
2025-10-15T15:39:43.733529Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:304: session v1 cookie: 1 sessionId: 123|80c93080-97ab740c-4d5bc25d-dbee53f7_0 is DEAD
2025-10-15T15:39:43.734303Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::TEvents::TEvPoison
2025-10-15T15:39:43.741615Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2743: [PQ: 72075186224037892] server disconnected, pipe [11:7561473677950011815:2463] destroyed
2025-10-15T15:39:43.741682Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:138: [72075186224037892][Partition][0][StateIdle] TPartition::DropOwner.
2025-10-15T15:39:43.741716Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:43.741743Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:43.741756Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:43.757195Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:43.757229Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:43.757244Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:43.858071Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:43.858107Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:43.858123Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:43.961235Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:43.961269Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:43.961281Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.007304Z node 11 :KQP_EXECUTER ERROR: kqp_planner.cpp:123: TxId: 281474976710703. Ctx: { TraceId: 01k7m8dy9m28xwxf821cjakw09, Database: , SessionId: ydb://session/3?node_id=11&id=NWJmMWNkMi1mMTdlMjMzLWNlYzdlNjE5LWU4NzBmYmMy, PoolId: default, DatabaseId: /Root}. Database not set, use /Root
2025-10-15T15:39:44.050840Z node 11 :PQ_READ_PROXY DEBUG: grpc_pq_schema.cpp:197: new Alter topic request
2025-10-15T15:39:44.052664Z node 11 :TX_PROXY ERROR: schemereq.cpp:590: Actor# [11:7561473682244979192:4013] txid# 281474976710704, 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-10-15T15:39:44.061331Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.061371Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.061382Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.085967Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:107: new grpc connection
2025-10-15T15:39:44.085991Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:141: new session created cookie 2
2025-10-15T15:39:44.086883Z 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-10-15T15:39:44.086951Z 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]:35408
2025-10-15T15:39:44.086961Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:1538: write session:  cookie=2 sessionId= userAgent="pqv1 server" ip=ipv6:[::1]:35408 proto=v1  topic=/Root/topic-f1 durationSec=0
2025-10-15T15:39:44.086968Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:571: init check schema
2025-10-15T15:39:44.088009Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:632: session v1 cookie: 2 sessionId:  describe result for acl check
2025-10-15T15:39:44.088114Z 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-10-15T15:39:44.088120Z 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-10-15T15:39:44.088126Z 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-10-15T15:39:44.088187Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:111: TPartitionChooser [11:7561473682244979212:2695] (SourceId=123, PreferedPartition=(NULL)) StartKqpSession
2025-10-15T15:39:44.090726Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:142: TPartitionChooser [11:7561473682244979212:2695] (SourceId=123, PreferedPartition=(NULL)) Select from the table
2025-10-15T15:39:44.097422Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:174: TPartitionChooser [11:7561473682244979212:2695] (SourceId=123, PreferedPartition=(NULL)) Update the table
2025-10-15T15:39:44.110680Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:183: TPartitionChooser [11:7561473682244979212:2695] (SourceId=123, PreferedPartition=(NULL)) HandleUpdate PartitionPersisted=0 Status=SUCCESS
2025-10-15T15:39:44.110720Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:305: TPartitionChooser [11:7561473682244979212:2695] (SourceId=123, PreferedPartition=(NULL)) ReplyResult: Partition=0, SeqNo=0
2025-10-15T15:39:44.110737Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:268: TPartitionChooser [11:7561473682244979212:2695] (SourceId=123, PreferedPartition=(NULL)) Start idle
2025-10-15T15:39:44.110769Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:694: ProceedPartition. session cookie: 2 sessionId:  partition: 0 expectedGeneration: (NULL)
2025-10-15T15:39:44.112241Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2718: [PQ: 72075186224037892] server connected, pipe [11:7561473682244979245:2695], now have 1 active actors on pipe
2025-10-15T15:39:44.112374Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:822: TPartitionWriter 72075186224037892 (partition=0) TEvClientConnected Status OK, TabletId: 72075186224037892, NodeId 12, Generation: 1
2025-10-15T15:39:44.112548Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:44.112588Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:44.112667Z node 12 :PERSQUEUE INFO: ownerinfo.cpp:30: new Cookie 123|18691b28-ced6189-69fb6d39-86daad40_0 generated for partition 0 topic 'topic-f1' owner 123
2025-10-15T15:39:44.112694Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.112709Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.112719Z node 12 :PERSQUEUE DEBUG: partition.cpp:2340: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-10-15T15:39:44.112761Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.112799Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:35: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyOwnerOk. Partition: 0
2025-10-15T15:39:44.112846Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-10-15T15:39:44.113511Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:44.113542Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:44.113608Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-10-15T15:39:44.113812Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:871: session inited cookie: 2 partition: 0 MaxSeqNo: 10 sessionId: 123|18691b28-ced6189-69fb6d39-86daad40_0
2025-10-15T15:39:44.115089Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 2 sessionId: 123|18691b28-ced6189-69fb6d39-86daad40_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-10-15T15:39:44.115338Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-10-15T15:39:44.115734Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:44.115777Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:44.115836Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 1
2025-10-15T15:39:44.116180Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:44.116513Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:44.116540Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:44.116586Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2007: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 11 partNo : 0 messageNo: 1 size 80 offset: -1
2025-10-15T15:39:44.116627Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:637: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-10-15T15:39:44.116657Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.116688Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.116699Z node 12 :PERSQUEUE DEBUG: partition.cpp:2340: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-10-15T15:39:44.116797Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1319: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 11 partNo 0
2025-10-15T15:39:44.117743Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1423: [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-10-15T15:39:44.117781Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.118245Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1675: [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 1760542784118
2025-10-15T15:39:44.118383Z node 12 :PERSQUEUE DEBUG: read.h:275: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-10-15T15:39:44.118494Z node 12 :PERSQUEUE DEBUG: read.h:313: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough blob. Partition 0 offset 10 partNo 0 count 1 size 137
2025-10-15T15:39:44.122096Z node 12 :PERSQUEUE DEBUG: cache_eviction.h:321: Caching head blob in L1. Partition 0 offset 10 count 1 size 137 actorID [12:7561473657521150312:2323]
2025-10-15T15:39:44.122151Z node 12 :PERSQUEUE DEBUG: partition.cpp:2154: [72075186224037892][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-10-15T15:39:44.122204Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:574: [72075186224037892][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 84 WriteNewSizeFromSupportivePartitions# 0
2025-10-15T15:39:44.122209Z node 12 :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-10-15T15:39:44.122235Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:58: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-10-15T15:39:44.122265Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:361: [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-10-15T15:39:44.122440Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.122460Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.122470Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.122500Z node 12 :PERSQUEUE DEBUG: partition_compaction.cpp:193: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-10-15T15:39:44.122550Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 1  requestId: <none> cookie: 1
2025-10-15T15:39:44.122837Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:44.162146Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.162171Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.162181Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.226450Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2743: [PQ: 72075186224037892] server disconnected, pipe [11:7561473682244979245:2695] destroyed
2025-10-15T15:39:44.226508Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:138: [72075186224037892][Partition][0][StateIdle] TPartition::DropOwner.
2025-10-15T15:39:44.226538Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.226550Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.226562Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.225256Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 2 sessionId: 123|18691b28-ced6189-69fb6d39-86daad40_0 grpc read done: success: 0 data: 
2025-10-15T15:39:44.225288Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:256: session v1 cookie: 2 sessionId: 123|18691b28-ced6189-69fb6d39-86daad40_0 grpc read failed
2025-10-15T15:39:44.225322Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:232: session v1 cookie: 2 sessionId: 123|18691b28-ced6189-69fb6d39-86daad40_0 grpc closed
2025-10-15T15:39:44.225334Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:304: session v1 cookie: 2 sessionId: 123|18691b28-ced6189-69fb6d39-86daad40_0 is DEAD
2025-10-15T15:39:44.226100Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::TEvents::TEvPoison
2025-10-15T15:39:44.262586Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.262612Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.262624Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.365338Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.365380Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.365392Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.418432Z node 11 :KQP_EXECUTER ERROR: kqp_planner.cpp:123: TxId: 281474976710709. Ctx: { TraceId: 01k7m8dyqq22j3yb1htpf1ay36, Database: , SessionId: ydb://session/3?node_id=11&id=NDhmYzkyOTMtNTM0MzI3MzEtZDEwMjUxY2ItYTk1ZjM4YjI=, PoolId: default, DatabaseId: /Root}. Database not set, use /Root
2025-10-15T15:39:44.472843Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.472874Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.472888Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.473917Z node 11 :PQ_READ_PROXY DEBUG: grpc_pq_schema.cpp:197: new Alter topic request
2025-10-15T15:39:44.477773Z node 11 :TX_PROXY ERROR: schemereq.cpp:590: Actor# [11:7561473682244979312:4059] txid# 281474976710710, 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-10-15T15:39:44.530536Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:107: new grpc connection
2025-10-15T15:39:44.530572Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:141: new session created cookie 3
2025-10-15T15:39:44.531120Z 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-10-15T15:39:44.531222Z 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]:35446
2025-10-15T15:39:44.531245Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:1538: write session:  cookie=3 sessionId= userAgent="pqv1 server" ip=ipv6:[::1]:35446 proto=v1  topic=/Root/topic-f1 durationSec=0
2025-10-15T15:39:44.531255Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:571: init check schema
2025-10-15T15:39:44.532263Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:632: session v1 cookie: 3 sessionId:  describe result for acl check
2025-10-15T15:39:44.532404Z 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-10-15T15:39:44.532414Z 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-10-15T15:39:44.532447Z 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-10-15T15:39:44.532514Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:111: TPartitionChooser [11:7561473682244979322:2726] (SourceId=123, PreferedPartition=(NULL)) StartKqpSession
2025-10-15T15:39:44.535198Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:142: TPartitionChooser [11:7561473682244979322:2726] (SourceId=123, PreferedPartition=(NULL)) Select from the table
2025-10-15T15:39:44.542270Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:174: TPartitionChooser [11:7561473682244979322:2726] (SourceId=123, PreferedPartition=(NULL)) Update the table
2025-10-15T15:39:44.550817Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:183: TPartitionChooser [11:7561473682244979322:2726] (SourceId=123, PreferedPartition=(NULL)) HandleUpdate PartitionPersisted=0 Status=SUCCESS
2025-10-15T15:39:44.550857Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:305: TPartitionChooser [11:7561473682244979322:2726] (SourceId=123, PreferedPartition=(NULL)) ReplyResult: Partition=0, SeqNo=0
2025-10-15T15:39:44.550875Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:268: TPartitionChooser [11:7561473682244979322:2726] (SourceId=123, PreferedPartition=(NULL)) Start idle
2025-10-15T15:39:44.550906Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:694: ProceedPartition. session cookie: 3 sessionId:  partition: 0 expectedGeneration: (NULL)
2025-10-15T15:39:44.552849Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2718: [PQ: 72075186224037892] server connected, pipe [11:7561473682244979355:2726], now have 1 active actors on pipe
2025-10-15T15:39:44.553102Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:822: TPartitionWriter 72075186224037892 (partition=0) TEvClientConnected Status OK, TabletId: 72075186224037892, NodeId 12, Generation: 1
2025-10-15T15:39:44.553420Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:44.553453Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:44.553518Z node 12 :PERSQUEUE INFO: ownerinfo.cpp:30: new Cookie 123|72ff2f27-86b95bb5-b44cf82-1e8bf4d_0 generated for partition 0 topic 'topic-f1' owner 123
2025-10-15T15:39:44.553554Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.553569Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.553581Z node 12 :PERSQUEUE DEBUG: partition.cpp:2340: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-10-15T15:39:44.553620Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.553658Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:35: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyOwnerOk. Partition: 0
2025-10-15T15:39:44.553705Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-10-15T15:39:44.554529Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:44.554556Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:44.554616Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-10-15T15:39:44.554901Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:871: session inited cookie: 3 partition: 0 MaxSeqNo: 11 sessionId: 123|72ff2f27-86b95bb5-b44cf82-1e8bf4d_0
2025-10-15T15:39:44.556448Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 3 sessionId: 123|72ff2f27-86b95bb5-b44cf82-1e8bf4d_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-10-15T15:39:44.556646Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-10-15T15:39:44.557082Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:44.557121Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:44.557180Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 1
2025-10-15T15:39:44.557450Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:44.557826Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:44.557845Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:44.557885Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2007: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 12 partNo : 0 messageNo: 1 size 80 offset: -1
2025-10-15T15:39:44.557914Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:637: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-10-15T15:39:44.557955Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.557976Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.557988Z node 12 :PERSQUEUE DEBUG: partition.cpp:2340: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-10-15T15:39:44.558087Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1319: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 12 partNo 0
2025-10-15T15:39:44.558984Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1423: [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-10-15T15:39:44.559017Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.559456Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1675: [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 1760542784558
2025-10-15T15:39:44.559588Z node 12 :PERSQUEUE DEBUG: read.h:275: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-10-15T15:39:44.559695Z node 12 :PERSQUEUE DEBUG: read.h:313: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough blob. Partition 0 offset 11 partNo 0 count 1 size 137
2025-10-15T15:39:44.563326Z node 12 :PERSQUEUE DEBUG: cache_eviction.h:321: Caching head blob in L1. Partition 0 offset 11 count 1 size 137 actorID [12:7561473657521150312:2323]
2025-10-15T15:39:44.563376Z node 12 :PERSQUEUE DEBUG: partition.cpp:2154: [72075186224037892][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-10-15T15:39:44.563420Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:574: [72075186224037892][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 84 WriteNewSizeFromSupportivePartitions# 0
2025-10-15T15:39:44.563454Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:58: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-10-15T15:39:44.563484Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:361: [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-10-15T15:39:44.563658Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.563671Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.563682Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.563711Z node 12 :PERSQUEUE DEBUG: partition_compaction.cpp:193: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-10-15T15:39:44.563765Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 1  requestId: <none> cookie: 1
2025-10-15T15:39:44.564325Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:44.564118Z node 12 :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-10-15T15:39:44.569794Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.569819Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.569831Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.662754Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 3 sessionId: 123|72ff2f27-86b95bb5-b44cf82-1e8bf4d_0 grpc read done: success: 0 data: 
2025-10-15T15:39:44.662782Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:256: session v1 cookie: 3 sessionId: 123|72ff2f27-86b95bb5-b44cf82-1e8bf4d_0 grpc read failed
2025-10-15T15:39:44.662831Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:232: session v1 cookie: 3 sessionId: 123|72ff2f27-86b95bb5-b44cf82-1e8bf4d_0 grpc closed
2025-10-15T15:39:44.662843Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:304: session v1 cookie: 3 sessionId: 123|72ff2f27-86b95bb5-b44cf82-1e8bf4d_0 is DEAD
2025-10-15T15:39:44.663616Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::TEvents::TEvPoison
2025-10-15T15:39:44.665834Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2743: [PQ: 72075186224037892] server disconnected, pipe [11:7561473682244979355:2726] destroyed
2025-10-15T15:39:44.665872Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:138: [72075186224037892][Partition][0][StateIdle] TPartition::DropOwner.
2025-10-15T15:39:44.665899Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.665911Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.665921Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.671721Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.671763Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.671783Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.773204Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.773230Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.773242Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.873474Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.873508Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.873523Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.975223Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:44.975251Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:44.975264Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:44.982322Z node 11 :KQP_EXECUTER ERROR: kqp_planner.cpp:123: TxId: 281474976710714. Ctx: { TraceId: 01k7m8dz5p9mm9hycs19cn2psk, Database: , SessionId: ydb://session/3?node_id=11&id=YjU1MWU4NjMtYWU5N2ZjNWEtODBlMzkwN2ItNWVhOWUwNWM=, PoolId: default, DatabaseId: /Root}. Database not set, use /Root
2025-10-15T15:39:45.037235Z node 11 :PQ_READ_PROXY DEBUG: grpc_pq_schema.cpp:197: new Alter topic request
2025-10-15T15:39:45.038103Z node 11 :TX_PROXY ERROR: schemereq.cpp:590: Actor# [11:7561473686539946727:4113] txid# 281474976710715, 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-10-15T15:39:45.076791Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:45.076840Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:45.076859Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:45.101868Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:107: new grpc connection
2025-10-15T15:39:45.101903Z node 11 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:141: new session created cookie 4
2025-10-15T15:39:45.105343Z 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-10-15T15:39:45.105484Z 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]:35504
2025-10-15T15:39:45.105504Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:1538: write session:  cookie=4 sessionId= userAgent="pqv1 server" ip=ipv6:[::1]:35504 proto=v1  topic=/Root/topic-f1 durationSec=0
2025-10-15T15:39:45.105516Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:571: init check schema
2025-10-15T15:39:45.109964Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:632: session v1 cookie: 4 sessionId:  describe result for acl check
2025-10-15T15:39:45.110139Z 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-10-15T15:39:45.110154Z 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-10-15T15:39:45.110165Z 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-10-15T15:39:45.110243Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:111: TPartitionChooser [11:7561473686539946741:2753] (SourceId=123, PreferedPartition=(NULL)) StartKqpSession
2025-10-15T15:39:45.119227Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:142: TPartitionChooser [11:7561473686539946741:2753] (SourceId=123, PreferedPartition=(NULL)) Select from the table
2025-10-15T15:39:45.126458Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:174: TPartitionChooser [11:7561473686539946741:2753] (SourceId=123, PreferedPartition=(NULL)) Update the table
2025-10-15T15:39:45.139129Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:183: TPartitionChooser [11:7561473686539946741:2753] (SourceId=123, PreferedPartition=(NULL)) HandleUpdate PartitionPersisted=0 Status=SUCCESS
2025-10-15T15:39:45.139177Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:305: TPartitionChooser [11:7561473686539946741:2753] (SourceId=123, PreferedPartition=(NULL)) ReplyResult: Partition=0, SeqNo=0
2025-10-15T15:39:45.139197Z node 11 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:268: TPartitionChooser [11:7561473686539946741:2753] (SourceId=123, PreferedPartition=(NULL)) Start idle
2025-10-15T15:39:45.139229Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:694: ProceedPartition. session cookie: 4 sessionId:  partition: 0 expectedGeneration: (NULL)
2025-10-15T15:39:45.142009Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:822: TPartitionWriter 72075186224037892 (partition=0) TEvClientConnected Status OK, TabletId: 72075186224037892, NodeId 12, Generation: 1
2025-10-15T15:39:45.141622Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2718: [PQ: 72075186224037892] server connected, pipe [11:7561473686539946775:2753], now have 1 active actors on pipe
2025-10-15T15:39:45.145423Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:45.145464Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:45.145541Z node 12 :PERSQUEUE INFO: ownerinfo.cpp:30: new Cookie 123|fc4ffde6-8e42b572-5bb569fb-3cef5963_0 generated for partition 0 topic 'topic-f1' owner 123
2025-10-15T15:39:45.145572Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:45.145588Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:45.145599Z node 12 :PERSQUEUE DEBUG: partition.cpp:2340: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-10-15T15:39:45.145648Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:45.145692Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:35: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyOwnerOk. Partition: 0
2025-10-15T15:39:45.145790Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-10-15T15:39:45.149682Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:45.149724Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:45.149805Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-10-15T15:39:45.150217Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:871: session inited cookie: 4 partition: 0 MaxSeqNo: 12 sessionId: 123|fc4ffde6-8e42b572-5bb569fb-3cef5963_0
2025-10-15T15:39:45.157328Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 4 sessionId: 123|fc4ffde6-8e42b572-5bb569fb-3cef5963_0 grpc read done: success: 1 data:  write_request[data omitted]
2025-10-15T15:39:45.157645Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NKikimr::NPQ::TEvPartitionWriter::TEvWriteRequest
2025-10-15T15:39:45.158280Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:45.158327Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:45.158409Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 0  requestId: <none> cookie: 1
2025-10-15T15:39:45.158854Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:45.159350Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic-f1' requestId: <none>
2025-10-15T15:39:45.159376Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2632: [PQ: 72075186224037892] got client message batch for topic 'topic-f1' partition 0
2025-10-15T15:39:45.159422Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2007: [PQ: 72075186224037892] got client message topic: topic-f1 partition: 0 SourceId: '\000123' SeqNo: 13 partNo : 0 messageNo: 1 size 80 offset: -1
2025-10-15T15:39:45.159458Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:637: [72075186224037892][Partition][0][StateIdle] Received TPartition::TEvWrite
2025-10-15T15:39:45.159500Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:45.159526Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:45.159539Z node 12 :PERSQUEUE DEBUG: partition.cpp:2340: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-10-15T15:39:45.159648Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1319: [72075186224037892][Partition][0][StateIdle] Topic 'topic-f1' partition 0 part blob processing sourceId '\000123' seqNo 13 partNo 0
2025-10-15T15:39:45.160555Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1423: [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-10-15T15:39:45.160591Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:45.161150Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:1675: [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 1760542785161
2025-10-15T15:39:45.161309Z node 12 :PERSQUEUE DEBUG: read.h:275: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-10-15T15:39:45.161446Z node 12 :PERSQUEUE DEBUG: read.h:313: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough blob. Partition 0 offset 12 partNo 0 count 1 size 137
2025-10-15T15:39:45.166447Z node 12 :PERSQUEUE DEBUG: cache_eviction.h:321: Caching head blob in L1. Partition 0 offset 12 count 1 size 137 actorID [12:7561473657521150312:2323]
2025-10-15T15:39:45.166528Z node 12 :PERSQUEUE DEBUG: partition.cpp:2154: [72075186224037892][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-10-15T15:39:45.166585Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:574: [72075186224037892][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 84 WriteNewSizeFromSupportivePartitions# 0
2025-10-15T15:39:45.166638Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:58: [72075186224037892][Partition][0][StateIdle] TPartition::ReplyWrite. Partition: 0
2025-10-15T15:39:45.166694Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:361: [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-10-15T15:39:45.166934Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:45.166952Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:45.166965Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:45.167005Z node 12 :PERSQUEUE DEBUG: partition_compaction.cpp:193: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-10-15T15:39:45.167057Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic-f1' partition: 0 messageNo: 1  requestId: <none> cookie: 1
2025-10-15T15:39:45.169324Z node 12 :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-10-15T15:39:45.169535Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::IEventHandle
2025-10-15T15:39:45.177368Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:45.177438Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:45.177457Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:45.261386Z node 11 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 4 sessionId: 123|fc4ffde6-8e42b572-5bb569fb-3cef5963_0 grpc read done: success: 0 data: 
2025-10-15T15:39:45.261415Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:256: session v1 cookie: 4 sessionId: 123|fc4ffde6-8e42b572-5bb569fb-3cef5963_0 grpc read failed
2025-10-15T15:39:45.261443Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:232: session v1 cookie: 4 sessionId: 123|fc4ffde6-8e42b572-5bb569fb-3cef5963_0 grpc closed
2025-10-15T15:39:45.261455Z node 11 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:304: session v1 cookie: 4 sessionId: 123|fc4ffde6-8e42b572-5bb569fb-3cef5963_0 is DEAD
2025-10-15T15:39:45.262170Z node 11 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037892 (partition=0) Received event: NActors::TEvents::TEvPoison
2025-10-15T15:39:45.265358Z node 12 :PERSQUEUE DEBUG: pq_impl.cpp:2743: [PQ: 72075186224037892] server disconnected, pipe [11:7561473686539946775:2753] destroyed
2025-10-15T15:39:45.265403Z node 12 :PERSQUEUE DEBUG: partition_write.cpp:138: [72075186224037892][Partition][0][StateIdle] TPartition::DropOwner.
2025-10-15T15:39:45.265431Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:45.265444Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:45.265456Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:45.277831Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:45.277864Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:45.277876Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:45.379264Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:45.379295Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:45.379309Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:45.481121Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:45.481157Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:45.481173Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:45.522310Z node 11 :KQP_EXECUTER ERROR: kqp_planner.cpp:123: TxId: 281474976710720. Ctx: { TraceId: 01k7m8dzr43fkzfza2epth5d0q, Database: , SessionId: ydb://session/3?node_id=11&id=M2EyZjk0YWUtZTUzNjhhZTItYjA0ZjFhZjMtNmJjOTgwYjA=, PoolId: default, DatabaseId: /Root}. Database not set, use /Root
2025-10-15T15:39:45.581602Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:45.581632Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:45.581646Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
2025-10-15T15:39:45.684718Z node 12 :PERSQUEUE DEBUG: partition.cpp:2327: [72075186224037892][Partition][0][StateIdle] Batching state before ContinueProcessTxsAndUserActs: 0
2025-10-15T15:39:45.684747Z node 12 :PERSQUEUE DEBUG: partition.cpp:2336: [72075186224037892][Partition][0][StateIdle] Batching state after ContinueProcessTxsAndUserActs: 1
2025-10-15T15:39:45.684762Z node 12 :PERSQUEUE DEBUG: partition.cpp:2359: [72075186224037892][Partition][0][StateIdle] Try persist
