2025-11-26T18:40:48.961904Z node 18 :METADATA_PROVIDER WARN: log.cpp:841: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[18:7577105918482219713:2078];send_to=[0:7307199536658146131:7762515];
2025-11-26T18:40:48.961928Z node 18 :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-11-26T18:40:48.964079Z node 19 :METADATA_PROVIDER WARN: log.cpp:841: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[19:7577105919604803436:2080];send_to=[0:7307199536658146131:7762515];
2025-11-26T18:40:48.964096Z node 19 :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/2nbs/000cdc/r3tmp/tmpVokL5X/pdisk_1.dat
2025-11-26T18:40:48.966684Z node 19 :PQ_READ_PROXY DEBUG: caching_service.cpp:44: Direct read cache: : Created
2025-11-26T18:40:48.966883Z node 19 :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-11-26T18:40:48.965102Z node 18 :PQ_READ_PROXY DEBUG: caching_service.cpp:44: Direct read cache: : Created
2025-11-26T18:40:48.965596Z node 18 :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-11-26T18:40:48.987706Z node 19 :CONFIGS_DISPATCHER ERROR: configs_dispatcher.cpp:1233: Notification cookie mismatch for subscription [19:7577105919604803383:2073] 1764182448963810 != 1764182448963807
2025-11-26T18:40:48.988042Z node 18 :IMPORT WARN: schemeshard_import.cpp:307: Table profiles were not loaded
2025-11-26T18:40:48.992357Z node 18 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(19, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-26T18:40:48.992377Z node 18 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(19, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-26T18:40:48.993681Z node 18 :HIVE WARN: hive_impl.cpp:811: HIVE#72057594037968897 Handle TEvInterconnect::TEvNodeConnected, NodeId 19 Cookie 19
2025-11-26T18:40:48.993930Z node 18 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(19, (0,0,0,0)) VolatileState: Connecting -> Connected
TServer::EnableGrpc on GrpcPort 12585, node 18
2025-11-26T18:40:49.001433Z node 18 :NET_CLASSIFIER WARN: net_classifier.cpp:190: distributable config is empty, broken or outdated, will use file: /home/runner/.ya/build/build_root/2nbs/000cdc/r3tmp/yandexBZZyKM.tmp
2025-11-26T18:40:49.001449Z node 18 :NET_CLASSIFIER WARN: net_classifier.cpp:196: will try to initialize from file: /home/runner/.ya/build/build_root/2nbs/000cdc/r3tmp/yandexBZZyKM.tmp
2025-11-26T18:40:49.001513Z node 18 :NET_CLASSIFIER WARN: net_classifier.cpp:202: successfully initialized from file: /home/runner/.ya/build/build_root/2nbs/000cdc/r3tmp/yandexBZZyKM.tmp
2025-11-26T18:40:49.001573Z node 18 :NET_CLASSIFIER ERROR: net_classifier.cpp:228: got bad distributable configuration
2025-11-26T18:40:49.005825Z INFO: TTestServer started on Port 8458 GrpcPort 12585
TClient is connected to server localhost:8458
PQClient connected to localhost:12585
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-11-26T18:40:49.064786Z node 18 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(18, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-26T18:40:49.064822Z node 18 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(18, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-26T18:40:49.066124Z node 18 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 281474976720657:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_alter_subdomain.cpp:311)
2025-11-26T18:40:49.066724Z node 18 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(18, (0,0,0,0)) VolatileState: Connecting -> Connected
waiting...
2025-11-26T18:40:49.071690Z node 18 :FLAT_TX_SCHEMESHARD WARN: schemeshard__notify.cpp:122: NotifyTxCompletion, unknown transaction, txId: 281474976720657, at schemeshard: 72057594046644480
waiting...
2025-11-26T18:40:49.080157Z node 18 :FLAT_TX_SCHEMESHARD WARN: schemeshard__notify.cpp:122: NotifyTxCompletion, unknown transaction, txId: 281474976720658, at schemeshard: 72057594046644480
waiting...
2025-11-26T18:40:49.081518Z node 18 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976720659:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:690)
waiting...
waiting...
2025-11-26T18:40:49.140856Z node 18 :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-11-26T18:40:49.193849Z node 19 :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-11-26T18:40:49.470959Z node 19 :KQP_COMPILE_ACTOR ERROR: kqp_compile_actor.cpp:566: Compilation failed, self: [19:7577105923899771013:2289], 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-11-26T18:40:49.471480Z node 19 :KQP_SESSION WARN: kqp_session_actor.cpp:2444: SessionId: ydb://session/3?node_id=19&id=MzIyNGY3YjItYjcyY2MxNzItMzg1ZDllMDMtOTc4ODcxYWQ=, ActorId: [19:7577105923899771011:2288], ActorState: ExecuteState, TraceId: 01kb0qfq9r50f8pfc7dns49z13, ReplyQueryCompileError, status: SCHEME_ERROR, issues: { 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 } } }, remove tx with tx_id: 
2025-11-26T18:40:49.471645Z node 19 :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-11-26T18:40:49.517765Z node 18 :KQP_COMPILE_ACTOR ERROR: kqp_compile_actor.cpp:566: Compilation failed, self: [18:7577105922777188076:2323], 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-11-26T18:40:49.519102Z node 18 :KQP_SESSION WARN: kqp_session_actor.cpp:2444: SessionId: ydb://session/3?node_id=18&id=ZmY4ZDgwODAtYTY5ODFmZjctNTExNzQ3YzMtNjI3OGUyYjY=, ActorId: [18:7577105922777188073:2321], ActorState: ExecuteState, TraceId: 01kb0qfqb3ebg6vambqz4sdxr9, ReplyQueryCompileError, status: SCHEME_ERROR, issues: { 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 } } }, remove tx with tx_id: 
2025-11-26T18:40:49.519232Z node 18 :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-11-26T18:40:49.539660Z node 18 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976720662: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:690)
2025-11-26T18:40:49.604873Z node 18 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976720663:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:690)
2025-11-26T18:40:49.645902Z node 18 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976720664:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:690)
=== Init DC: UPSERT INTO `/Root/PQ/Config/V2/Cluster` (name, balancer, local, enabled, weight) VALUES ("dc1", "localhost", true, true, 1000), ("dc2", "dc2.logbroker.yandex.net", false, true, 1000);
2025-11-26T18:40:49.711430Z node 18 :KQP_EXECUTER ERROR: kqp_planner.cpp:123: TxId: 281474976720665. Ctx: { TraceId: 01kb0qfqgd9djj02j6b391s4tw, Database: , SessionId: ydb://session/3?node_id=18&id=ZTEzYjRmNDYtNmM1YWU1NmItYmFhNDg3Y2EtYWM0OGVkYmU=, PoolId: , DatabaseId: /Root}. Database not set, use /Root
=== CheckClustersList. Subcribe to ClusterTracker from [18:7577105922777188418:2968] 
2025-11-26T18:40:49.965405Z node 18 :TX_CONVEYOR ERROR: log.cpp:841: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-11-26T18:40:49.966955Z node 19 :TX_CONVEYOR ERROR: log.cpp:841: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-11-26T18:40:53.962534Z node 18 :METADATA_PROVIDER ERROR: log.cpp:841: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[18:7577105918482219713:2078];send_to=[0:7307199536658146131:7762515];
2025-11-26T18:40:53.962581Z node 18 :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-11-26T18:40:53.967139Z node 19 :METADATA_PROVIDER ERROR: log.cpp:841: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[19:7577105919604803436:2080];send_to=[0:7307199536658146131:7762515];
2025-11-26T18:40:53.967191Z node 19 :METADATA_PROVIDER ERROR: log.cpp:841: fline=accessor_snapshot_base.cpp:71;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=timeout;
=== CheckClustersList. Ok
CreateTopicNoLegacy: rt3.dc2--account--topic1
Create topic: /Root/PQ/rt3.dc2--account--topic1
AddTopic: rt3.dc2--account--topic1
===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 = account/topic1, dc = dc2
2025-11-26T18:40:54.967919Z node 18 :PQ_READ_PROXY DEBUG: grpc_pq_schema.cpp:196: new Create topic request
2025-11-26T18:40:54.983187Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2959: [PQ: 72075186224037892] Handle TEvInterconnect::TEvNodeInfo
2025-11-26T18:40:54.984465Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2991: [PQ: 72075186224037892] Transactions request. From tx_00000000000000000000, To tx_18446744073709551615
2025-11-26T18:40:54.984531Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:785: [PQ: 72075186224037892] no config, start with empty partitions and default config
2025-11-26T18:40:54.984540Z node 18 :PERSQUEUE NOTICE: pq_impl.cpp:911: [PQ: 72075186224037892] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-11-26T18:40:54.984555Z node 18 :PERSQUEUE INFO: pq_impl.cpp:612: [PQ: 72075186224037892] doesn't have tx writes info
2025-11-26T18:40:54.984870Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037892] server connected, pipe [18:7577105944252025317:3179], now have 1 active actors on pipe
2025-11-26T18:40:54.985014Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:54.985964Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.000170Z node 18 :KQP_EXECUTER ERROR: kqp_planner.cpp:123: TxId: 281474976720678. Ctx: { TraceId: 01kb0qfwnv5mf59bqt2qs0g8td, Database: , SessionId: ydb://session/3?node_id=18&id=NzFkNDQyZTktN2RhY2JmYTYtMmRmODQwYzUtZDhkYzE5MmM=, PoolId: , DatabaseId: /Root}. Database not set, use /Root
===Query complete
2025-11-26T18:40:55.028327Z node 19 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1653: [72075186224037893][] pipe [18:7577105944252025318:3180] connected; active server actors: 1
2025-11-26T18:40:55.028503Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer__balancing.cpp:1517: [72075186224037893][rt3.dc2--account--topic1] updating configuration. Deleted partitions []. Added partitions [0]
2025-11-26T18:40:55.028773Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:969: [72075186224037893][rt3.dc2--account--topic1] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037893
2025-11-26T18:40:55.029027Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:402: [72075186224037893][rt3.dc2--account--topic1] TEvClientConnected TabletId 72075186224037892, NodeId 18, Generation 1
2025-11-26T18:40:55.029030Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037892] server connected, pipe [19:7577105949669575334:2383], now have 1 active actors on pipe
2025-11-26T18:40:55.029492Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:138: [72075186224037893][rt3.dc2--account--topic1] BALANCER INIT DONE for rt3.dc2--account--topic1: (0, 72075186224037892) 
2025-11-26T18:40:55.031085Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037892] server connected, pipe [18:7577105948546992715:3259], now have 1 active actors on pipe
2025-11-26T18:40:55.031166Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.032052Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.032198Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc2--account--topic1:0:Initializer] Start initializing step TInitConfigStep
2025-11-26T18:40:55.032211Z node 18 :PERSQUEUE DEBUG: partition.cpp:1298: [72075186224037892][Partition][0][StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-11-26T18:40:55.032274Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc2--account--topic1:0:Initializer] Start initializing step TInitInternalFieldsStep
2025-11-26T18:40:55.032324Z node 18 :PERSQUEUE INFO: partition_init.cpp:1106: [72075186224037892][Partition][0][StateInit] bootstrapping 0 [18:7577105948546992727:2442]
2025-11-26T18:40:55.032943Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc2--account--topic1:0:Initializer] Start initializing step TInitFieldsStep
2025-11-26T18:40:55.032952Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:61: [rt3.dc2--account--topic1:0:Initializer] Initializing completed.
2025-11-26T18:40:55.032956Z node 18 :PERSQUEUE INFO: partition.cpp:695: [72075186224037892][Partition][0][StateInit] init complete for topic 'rt3.dc2--account--topic1' partition 0 generation 1 [18:7577105948546992727:2442]
2025-11-26T18:40:55.032962Z node 18 :PERSQUEUE DEBUG: partition.cpp:715: [72075186224037892][Partition][0][StateInit] SYNC INIT topic rt3.dc2--account--topic1 partitition 0 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-11-26T18:40:55.033169Z node 18 :PERSQUEUE DEBUG: partition.cpp:4392: [72075186224037892][Partition][0][StateIdle] Process pending events. Count 1
2025-11-26T18:40:55.033179Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.033182Z node 18 :PERSQUEUE DEBUG: partition.cpp:2375: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TTransaction[ProposeConfig])
2025-11-26T18:40:55.033193Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.033194Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.033196Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.033197Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.033204Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.033205Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.033207Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.033208Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.033209Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.033215Z node 18 :PERSQUEUE DEBUG: partition_read.cpp:915: [72075186224037892][Partition][0][StateIdle] Topic 'rt3.dc2--account--topic1' partition 0 user user readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-11-26T18:40:55.033317Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.033336Z node 18 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-11-26T18:40:55.034025Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.034070Z node 18 :PERSQUEUE DEBUG: partition.cpp:1403: [72075186224037892][Partition][0][StateIdle] Handle TEvPQ::TEvTxCommit Step 1764182455077, TxId 281474976720677
2025-11-26T18:40:55.034077Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.034079Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.034080Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.034085Z node 18 :PERSQUEUE DEBUG: partition.cpp:2439: [72075186224037892][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TTransaction[ProposeConfig])
2025-11-26T18:40:55.034108Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-11-26T18:40:55.034113Z node 18 :PERSQUEUE DEBUG: partition.cpp:2301: [72075186224037892][Partition][0][StateIdle] Batch completed (1)
2025-11-26T18:40:55.034114Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.034145Z node 18 :PERSQUEUE DEBUG: read.h:275: [72075186224037892][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-11-26T18:40:55.034516Z node 18 :PERSQUEUE DEBUG: partition.cpp:2112: [72075186224037892][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-11-26T18:40:55.034578Z node 18 :PERSQUEUE DEBUG: partition_write.cpp:570: [72075186224037892][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-11-26T18:40:55.034586Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.034588Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.034589Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.034590Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.034591Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.034594Z node 18 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037892][Partition][0][StateIdle] No data for blobs compaction
2025-11-26T18:40:55.034694Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:398: [PQ: 72075186224037892] Apply new config PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 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: "rt3.dc2--account--topic1" Version: 0 LocalDC: false RequireAuthWrite: true RequireAuthRead: true Producer: "account" Ident: "account" Topic: "topic1" DC: "dc2" FormatVersion: 0 Codecs { } TopicPath: "/Root/PQ/rt3.dc2--account--topic1" 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-11-26T18:40:55.034712Z node 18 :PERSQUEUE NOTICE: pq_impl.cpp:911: [PQ: 72075186224037892] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-11-26T18:40:55.034745Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.035547Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.035567Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.036132Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
Create topic result: 1 
CreateTopicNoLegacy: rt3.dc1--account--topic1
Create topic: /Root/PQ/rt3.dc1--account--topic1
AddTopic: rt3.dc1--account--topic1
===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 = account/topic1, dc = dc1
2025-11-26T18:40:55.037624Z node 18 :PQ_READ_PROXY DEBUG: grpc_pq_schema.cpp:196: new Create topic request
2025-11-26T18:40:55.043771Z node 19 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1653: [72075186224037895][] pipe [18:7577105948546992860:3374] connected; active server actors: 1
2025-11-26T18:40:55.043784Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2959: [PQ: 72075186224037894] Handle TEvInterconnect::TEvNodeInfo
2025-11-26T18:40:55.043830Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer__balancing.cpp:1517: [72075186224037895][rt3.dc1--account--topic1] updating configuration. Deleted partitions []. Added partitions [0]
2025-11-26T18:40:55.043920Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:969: [72075186224037895][rt3.dc1--account--topic1] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037895
2025-11-26T18:40:55.044698Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:138: [72075186224037895][rt3.dc1--account--topic1] BALANCER INIT DONE for rt3.dc1--account--topic1: (0, 72075186224037894) 
2025-11-26T18:40:55.044719Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2991: [PQ: 72075186224037894] Transactions request. From tx_00000000000000000000, To tx_18446744073709551615
2025-11-26T18:40:55.044766Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:785: [PQ: 72075186224037894] no config, start with empty partitions and default config
2025-11-26T18:40:55.044778Z node 18 :PERSQUEUE NOTICE: pq_impl.cpp:911: [PQ: 72075186224037894] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-11-26T18:40:55.044792Z node 18 :PERSQUEUE INFO: pq_impl.cpp:612: [PQ: 72075186224037894] doesn't have tx writes info
2025-11-26T18:40:55.044817Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037894] server connected, pipe [18:7577105948546992858:3372], now have 1 active actors on pipe
2025-11-26T18:40:55.044829Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037894] server connected, pipe [19:7577105949669575366:2384], now have 1 active actors on pipe
2025-11-26T18:40:55.044872Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:402: [72075186224037895][rt3.dc1--account--topic1] TEvClientConnected TabletId 72075186224037894, NodeId 18, Generation 1
2025-11-26T18:40:55.044913Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037894] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.045379Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037894] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.046323Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037894] server connected, pipe [18:7577105948546992936:3439], now have 1 active actors on pipe
2025-11-26T18:40:55.046362Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037894] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.046854Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037894] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.047019Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc1--account--topic1:0:Initializer] Start initializing step TInitConfigStep
2025-11-26T18:40:55.047035Z node 18 :PERSQUEUE DEBUG: partition.cpp:1298: [72075186224037894][Partition][0][StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-11-26T18:40:55.047088Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc1--account--topic1:0:Initializer] Start initializing step TInitInternalFieldsStep
2025-11-26T18:40:55.047135Z node 18 :PERSQUEUE INFO: partition_init.cpp:1106: [72075186224037894][Partition][0][StateInit] bootstrapping 0 [18:7577105948546992948:2465]
2025-11-26T18:40:55.047709Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc1--account--topic1:0:Initializer] Start initializing step TInitFieldsStep
2025-11-26T18:40:55.047718Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:61: [rt3.dc1--account--topic1:0:Initializer] Initializing completed.
2025-11-26T18:40:55.047721Z node 18 :PERSQUEUE INFO: partition.cpp:695: [72075186224037894][Partition][0][StateInit] init complete for topic 'rt3.dc1--account--topic1' partition 0 generation 1 [18:7577105948546992948:2465]
2025-11-26T18:40:55.047726Z node 18 :PERSQUEUE DEBUG: partition.cpp:715: [72075186224037894][Partition][0][StateInit] SYNC INIT topic rt3.dc1--account--topic1 partitition 0 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-11-26T18:40:55.047965Z node 18 :PERSQUEUE DEBUG: partition.cpp:4392: [72075186224037894][Partition][0][StateIdle] Process pending events. Count 1
2025-11-26T18:40:55.047977Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037894][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.047981Z node 18 :PERSQUEUE DEBUG: partition.cpp:2375: [72075186224037894][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TTransaction[ProposeConfig])
2025-11-26T18:40:55.047996Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.048003Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037894][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.048006Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.048007Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037894][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.048011Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037894][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.048013Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.048015Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037894][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.048016Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.048018Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037894][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.048026Z node 18 :PERSQUEUE DEBUG: partition_read.cpp:915: [72075186224037894][Partition][0][StateIdle] Topic 'rt3.dc1--account--topic1' partition 0 user user readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-11-26T18:40:55.048098Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037894] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.048127Z node 18 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037894][Partition][0][StateIdle] No data for blobs compaction
2025-11-26T18:40:55.048881Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037894] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.048910Z node 18 :PERSQUEUE DEBUG: partition.cpp:1403: [72075186224037894][Partition][0][StateIdle] Handle TEvPQ::TEvTxCommit Step 1764182455091, TxId 281474976720679
2025-11-26T18:40:55.048917Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037894][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.048918Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.048920Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037894][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.048923Z node 18 :PERSQUEUE DEBUG: partition.cpp:2439: [72075186224037894][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TTransaction[ProposeConfig])
2025-11-26T18:40:55.048939Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-11-26T18:40:55.048944Z node 18 :PERSQUEUE DEBUG: partition.cpp:2301: [72075186224037894][Partition][0][StateIdle] Batch completed (1)
2025-11-26T18:40:55.048945Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037894][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.048970Z node 18 :PERSQUEUE DEBUG: read.h:275: [72075186224037894][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-11-26T18:40:55.049276Z node 18 :PERSQUEUE DEBUG: partition.cpp:2112: [72075186224037894][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-11-26T18:40:55.049331Z node 18 :PERSQUEUE DEBUG: partition_write.cpp:570: [72075186224037894][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-11-26T18:40:55.049341Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037894][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.049342Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.049343Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037894][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.049344Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.049346Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037894][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.049350Z node 18 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037894][Partition][0][StateIdle] No data for blobs compaction
2025-11-26T18:40:55.049453Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:398: [PQ: 72075186224037894] 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: "rt3.dc1--account--topic1" Version: 0 LocalDC: true RequireAuthWrite: true RequireAuthRead: true Producer: "account" Ident: "account" Topic: "topic1" DC: "dc1" FormatVersion: 0 Codecs { } TopicPath: "/Root/PQ/rt3.dc1--account--topic1" 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-11-26T18:40:55.049470Z node 18 :PERSQUEUE NOTICE: pq_impl.cpp:911: [PQ: 72075186224037894] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-11-26T18:40:55.049503Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037894] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.050125Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037894] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.050140Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037894] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.050730Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037894] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.052113Z node 18 :KQP_EXECUTER ERROR: kqp_planner.cpp:123: TxId: 281474976720680. Ctx: { TraceId: 01kb0qfwqy9hqbryeyzwxw7fjs, Database: , SessionId: ydb://session/3?node_id=18&id=NmMwZTZmNS1kYjM1MDhiYi00ZTY5ZWViNi03MWI4Mzc4YQ==, PoolId: , DatabaseId: /Root}. Database not set, use /Root
===Query complete
Create topic result: 1 
2025-11-26T18:40:55.056166Z :DEBUG: [] MessageGroupId [src] SessionId [] Write session: try to update token
2025-11-26T18:40:55.056402Z :INFO: [] MessageGroupId [src] SessionId [] Write session: Do CDS request
2025-11-26T18:40:55.056406Z :INFO: [] MessageGroupId [src] SessionId [] Start write session. Will connect to endpoint: localhost:12585
2025-11-26T18:40:55.056748Z :DEBUG: [] MessageGroupId [src] SessionId [] Write session: send init request: init_request { topic: "account/topic1" message_group_id: "src" }
2025-11-26T18:40:55.056823Z node 18 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:107: new grpc connection
2025-11-26T18:40:55.056835Z node 18 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:141: new session created cookie 1
2025-11-26T18:40:55.056991Z node 18 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId:  grpc read done: success: 1 data: init_request { topic: "account/topic1" message_group_id: "src" }
2025-11-26T18:40:55.057015Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:447: session request cookie: 1 topic: "account/topic1" message_group_id: "src" from ipv6:[::1]:40108
2025-11-26T18:40:55.057022Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:1538: write session:  cookie=1 sessionId= userAgent="pqv1 server" ip=ipv6:[::1]:40108 proto=v1  topic=account/topic1 durationSec=0
2025-11-26T18:40:55.057025Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:571: init check schema
2025-11-26T18:40:55.057037Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:455: Handle describe topics
2025-11-26T18:40:55.057044Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:506: SendSchemeCacheRequest
2025-11-26T18:40:55.057057Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:541: send request for 1 topics, got 1 requests infly, db = ""
2025-11-26T18:40:55.057361Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:548: Handle SchemeCache response: result# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 2 ResultSet [{ Path: Root/PQ/rt3.dc1--account--topic1 TableId: [72057594046644480:10:0] RequestType: ByPath Operation: OpList RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: Ok Kind: KindTopic DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) Users: [] Groups: [] } }] }
2025-11-26T18:40:55.057380Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:613: Got describe topics SC response
2025-11-26T18:40:55.057604Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:632: session v1 cookie: 1 sessionId:  describe result for acl check
2025-11-26T18:40:55.057629Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__table_helper.h:62: TTableHelper SelectQuery: --!syntax_v1
DECLARE $Hash AS Uint32; DECLARE $Topic AS Utf8; DECLARE $SourceId AS Utf8;
SELECT Partition, CreateTime, AccessTime, SeqNo FROM `/Root/PQ/SourceIdMeta2` WHERE Hash == $Hash AND Topic == $Topic AND SourceId == $SourceId;
2025-11-26T18:40:55.057633Z node 18 :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 Uint32; DECLARE $Partition AS Uint32; DECLARE $CreateTime AS Uint64; DECLARE $AccessTime AS Uint64;DECLARE $SeqNo AS Uint64;
UPSERT INTO `/Root/PQ/SourceIdMeta2` (Hash, Topic, SourceId, CreateTime, AccessTime, Partition, SeqNo) VALUES ($Hash, $Topic, $SourceId, $CreateTime, $AccessTime, $Partition, $SeqNo);
2025-11-26T18:40:55.057635Z node 18 :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 Uint32; DECLARE $Partition AS Uint32; DECLARE $CreateTime AS Uint64; DECLARE $AccessTime AS Uint64;
UPDATE `/Root/PQ/SourceIdMeta2` SET AccessTime = $AccessTime WHERE Hash = $Hash AND Topic = $Topic AND SourceId = $SourceId AND Partition = $Partition;
2025-11-26T18:40:55.057638Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:111: TPartitionChooser [18:7577105948546993042:2476] (SourceId=src, PreferedPartition=(NULL)) StartKqpSession
2025-11-26T18:40:55.058075Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:142: TPartitionChooser [18:7577105948546993042:2476] (SourceId=src, PreferedPartition=(NULL)) Select from the table
2025-11-26T18:40:55.085076Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__old_chooser_actor.h:67: TPartitionChooser [18:7577105948546993042:2476] (SourceId=src, PreferedPartition=(NULL)) RequestPQRB
2025-11-26T18:40:55.085270Z node 19 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1653: [72075186224037895][rt3.dc1--account--topic1] pipe [18:7577105948546993074:2476] connected; active server actors: 1
2025-11-26T18:40:55.085432Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__old_chooser_actor.h:80: TPartitionChooser [18:7577105948546993042:2476] (SourceId=src, PreferedPartition=(NULL)) Received partition 0 from PQRB for SourceId=src
2025-11-26T18:40:55.085444Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:174: TPartitionChooser [18:7577105948546993042:2476] (SourceId=src, PreferedPartition=(NULL)) Update the table
2025-11-26T18:40:55.085574Z node 19 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1665: [72075186224037895][rt3.dc1--account--topic1] pipe [18:7577105948546993074:2476] disconnected; active server actors: 1
2025-11-26T18:40:55.085585Z node 19 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1689: [72075186224037895][rt3.dc1--account--topic1] pipe [18:7577105948546993074:2476] disconnected no session
2025-11-26T18:40:55.105294Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:183: TPartitionChooser [18:7577105948546993042:2476] (SourceId=src, PreferedPartition=(NULL)) HandleUpdate PartitionPersisted=0 Status=SUCCESS
2025-11-26T18:40:55.105314Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:305: TPartitionChooser [18:7577105948546993042:2476] (SourceId=src, PreferedPartition=(NULL)) ReplyResult: Partition=0, SeqNo=(NULL)
2025-11-26T18:40:55.105318Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:268: TPartitionChooser [18:7577105948546993042:2476] (SourceId=src, PreferedPartition=(NULL)) Start idle
2025-11-26T18:40:55.105328Z node 18 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:694: ProceedPartition. session cookie: 1 sessionId:  partition: 0 expectedGeneration: (NULL)
2025-11-26T18:40:55.105481Z node 18 :PQ_WRITE_PROXY DEBUG: writer.cpp:822: TPartitionWriter 72075186224037894 (partition=0) TEvClientConnected Status OK, TabletId: 72075186224037894, NodeId 18, Generation: 1
2025-11-26T18:40:55.105507Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037894] server connected, pipe [18:7577105948546993092:2476], now have 1 active actors on pipe
2025-11-26T18:40:55.105523Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'rt3.dc1--account--topic1' requestId: <none>
2025-11-26T18:40:55.105536Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037894] got client message batch for topic 'rt3.dc1--account--topic1' partition 0
2025-11-26T18:40:55.105573Z node 18 :PERSQUEUE INFO: ownerinfo.cpp:30: new Cookie src|5b828731-55895c07-83bba49e-e87bd5b8_0 generated for partition 0 topic 'rt3.dc1--account--topic1' owner src
2025-11-26T18:40:55.105591Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037894][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.105599Z node 18 :PERSQUEUE DEBUG: partition.cpp:2382: [72075186224037894][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-11-26T18:40:55.105607Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.105613Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037894][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.105618Z node 18 :PERSQUEUE DEBUG: partition.cpp:2446: [72075186224037894][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-11-26T18:40:55.105628Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-11-26T18:40:55.105637Z node 18 :PERSQUEUE DEBUG: partition.cpp:2301: [72075186224037894][Partition][0][StateIdle] Batch completed (1)
2025-11-26T18:40:55.105640Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037894][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.105659Z node 18 :PERSQUEUE DEBUG: partition_write.cpp:35: [72075186224037894][Partition][0][StateIdle] TPartition::ReplyOwnerOk. Partition: 0
2025-11-26T18:40:55.105679Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'rt3.dc1--account--topic1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-11-26T18:40:55.105721Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'rt3.dc1--account--topic1' requestId: <none>
2025-11-26T18:40:55.105729Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037894] got client message batch for topic 'rt3.dc1--account--topic1' partition 0
2025-11-26T18:40:55.105743Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'rt3.dc1--account--topic1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-11-26T18:40:55.105769Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:871: session inited cookie: 1 partition: 0 MaxSeqNo: 0 sessionId: src|5b828731-55895c07-83bba49e-e87bd5b8_0
2025-11-26T18:40:55.106169Z :INFO: [] MessageGroupId [src] SessionId [] Counters: { Errors: 0 CurrentSessionLifetimeMs: 1764182455106 BytesWritten: 0 MessagesWritten: 0 BytesWrittenCompressed: 0 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
2025-11-26T18:40:55.106210Z :INFO: [] MessageGroupId [src] SessionId [] Write session established. Init response: session_id: "src|5b828731-55895c07-83bba49e-e87bd5b8_0" topic: "account/topic1" cluster: "dc1"
2025-11-26T18:40:55.106366Z :INFO: [] MessageGroupId [src] SessionId [src|5b828731-55895c07-83bba49e-e87bd5b8_0] Write session: close. Timeout = 0 ms
2025-11-26T18:40:55.106376Z :INFO: [] MessageGroupId [src] SessionId [src|5b828731-55895c07-83bba49e-e87bd5b8_0] Write session will now close
2025-11-26T18:40:55.106381Z :DEBUG: [] MessageGroupId [src] SessionId [src|5b828731-55895c07-83bba49e-e87bd5b8_0] Write session: aborting
2025-11-26T18:40:55.106533Z :INFO: [] MessageGroupId [src] SessionId [src|5b828731-55895c07-83bba49e-e87bd5b8_0] Write session: gracefully shut down, all writes complete
2025-11-26T18:40:55.106546Z :DEBUG: [] MessageGroupId [src] SessionId [src|5b828731-55895c07-83bba49e-e87bd5b8_0] Write session: destroy
2025-11-26T18:40:55.106722Z node 18 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 1 sessionId: src|5b828731-55895c07-83bba49e-e87bd5b8_0 grpc read done: success: 0 data: 
2025-11-26T18:40:55.106733Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:256: session v1 cookie: 1 sessionId: src|5b828731-55895c07-83bba49e-e87bd5b8_0 grpc read failed
2025-11-26T18:40:55.106740Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:232: session v1 cookie: 1 sessionId: src|5b828731-55895c07-83bba49e-e87bd5b8_0 grpc closed
2025-11-26T18:40:55.106747Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:304: session v1 cookie: 1 sessionId: src|5b828731-55895c07-83bba49e-e87bd5b8_0 is DEAD
2025-11-26T18:40:55.107101Z node 18 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037894 (partition=0) Received event: NActors::TEvents::TEvPoison
2025-11-26T18:40:55.107165Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2745: [PQ: 72075186224037894] server disconnected, pipe [18:7577105948546993092:2476] destroyed
2025-11-26T18:40:55.107178Z node 18 :PERSQUEUE DEBUG: partition_write.cpp:138: [72075186224037894][Partition][0][StateIdle] TPartition::DropOwner.
2025-11-26T18:40:55.107189Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037894][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.107197Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.107199Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037894][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.107202Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.107204Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037894][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.108820Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:969: [72075186224037893][rt3.dc2--account--topic1] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037893
2025-11-26T18:40:55.108861Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:969: [72075186224037895][rt3.dc1--account--topic1] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037895
waiting...
2025-11-26T18:40:55.110255Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:969: [72075186224037893][rt3.dc2--account--topic1] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037893
2025-11-26T18:40:55.110277Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:969: [72075186224037895][rt3.dc1--account--topic1] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037895
waiting...
2025-11-26T18:40:55.112252Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:969: [72075186224037893][rt3.dc2--account--topic1] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037893
2025-11-26T18:40:55.112261Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:969: [72075186224037895][rt3.dc1--account--topic1] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037895
CreateTopicNoLegacy: /Root/LbCommunal/account/topic2
Create topic: /Root/LbCommunal/account/topic2
AddTopic: /Root/LbCommunal/account/topic2
===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/LbCommunal/account/topic2, dc = unknown
2025-11-26T18:40:55.121928Z node 18 :PQ_READ_PROXY DEBUG: grpc_pq_schema.cpp:196: new Create topic request
2025-11-26T18:40:55.129118Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2959: [PQ: 72075186224037896] Handle TEvInterconnect::TEvNodeInfo
2025-11-26T18:40:55.129726Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2991: [PQ: 72075186224037896] Transactions request. From tx_00000000000000000000, To tx_18446744073709551615
2025-11-26T18:40:55.129785Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:785: [PQ: 72075186224037896] no config, start with empty partitions and default config
2025-11-26T18:40:55.129800Z node 18 :PERSQUEUE NOTICE: pq_impl.cpp:911: [PQ: 72075186224037896] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-11-26T18:40:55.129814Z node 18 :PERSQUEUE INFO: pq_impl.cpp:612: [PQ: 72075186224037896] doesn't have tx writes info
2025-11-26T18:40:55.129904Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037896] server connected, pipe [18:7577105948546993248:3657], now have 1 active actors on pipe
2025-11-26T18:40:55.130187Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037896] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.130821Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037896] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.131572Z node 19 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1653: [72075186224037897][] pipe [18:7577105948546993249:3658] connected; active server actors: 1
2025-11-26T18:40:55.131659Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer__balancing.cpp:1517: [72075186224037897][topic2] updating configuration. Deleted partitions []. Added partitions [0]
2025-11-26T18:40:55.131774Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:969: [72075186224037897][topic2] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037897
2025-11-26T18:40:55.132225Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037896] server connected, pipe [19:7577105949669575402:2385], now have 1 active actors on pipe
2025-11-26T18:40:55.132248Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:402: [72075186224037897][topic2] TEvClientConnected TabletId 72075186224037896, NodeId 18, Generation 1
2025-11-26T18:40:55.132306Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:138: [72075186224037897][topic2] BALANCER INIT DONE for topic2: (0, 72075186224037896) 
2025-11-26T18:40:55.133485Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.133496Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.133499Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.133501Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.133504Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.133710Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037896] server connected, pipe [18:7577105948546993328:3726], now have 1 active actors on pipe
2025-11-26T18:40:55.133792Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037896] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.134566Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037896] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.134783Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc1--account--topic2:0:Initializer] Start initializing step TInitConfigStep
2025-11-26T18:40:55.134796Z node 18 :PERSQUEUE DEBUG: partition.cpp:1298: [72075186224037896][Partition][0][StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-11-26T18:40:55.134858Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc1--account--topic2:0:Initializer] Start initializing step TInitInternalFieldsStep
2025-11-26T18:40:55.134912Z node 18 :PERSQUEUE INFO: partition_init.cpp:1106: [72075186224037896][Partition][0][StateInit] bootstrapping 0 [18:7577105948546993340:2501]
2025-11-26T18:40:55.135840Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc1--account--topic2:0:Initializer] Start initializing step TInitFieldsStep
2025-11-26T18:40:55.135849Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:61: [rt3.dc1--account--topic2:0:Initializer] Initializing completed.
2025-11-26T18:40:55.135855Z node 18 :PERSQUEUE INFO: partition.cpp:695: [72075186224037896][Partition][0][StateInit] init complete for topic 'rt3.dc1--account--topic2' partition 0 generation 1 [18:7577105948546993340:2501]
2025-11-26T18:40:55.135863Z node 18 :PERSQUEUE DEBUG: partition.cpp:715: [72075186224037896][Partition][0][StateInit] SYNC INIT topic rt3.dc1--account--topic2 partitition 0 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-11-26T18:40:55.135874Z node 18 :PERSQUEUE DEBUG: partition.cpp:4392: [72075186224037896][Partition][0][StateIdle] Process pending events. Count 1
2025-11-26T18:40:55.135880Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037896][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.135885Z node 18 :PERSQUEUE DEBUG: partition.cpp:2375: [72075186224037896][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TTransaction[ProposeConfig])
2025-11-26T18:40:55.135899Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.135901Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037896][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.135904Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.135906Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037896][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.135914Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037896][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.135915Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.135917Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037896][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.135919Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.135921Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037896][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.136000Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037896] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.136025Z node 18 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037896][Partition][0][StateIdle] No data for blobs compaction
2025-11-26T18:40:55.137179Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037896] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.137218Z node 18 :PERSQUEUE DEBUG: partition.cpp:1403: [72075186224037896][Partition][0][StateIdle] Handle TEvPQ::TEvTxCommit Step 1764182455182, TxId 281474976720685
2025-11-26T18:40:55.137223Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037896][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.137225Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.137226Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037896][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.137232Z node 18 :PERSQUEUE DEBUG: partition.cpp:2439: [72075186224037896][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TTransaction[ProposeConfig])
2025-11-26T18:40:55.137250Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-11-26T18:40:55.137251Z node 18 :PERSQUEUE DEBUG: partition.cpp:2301: [72075186224037896][Partition][0][StateIdle] Batch completed (1)
2025-11-26T18:40:55.137254Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037896][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.137284Z node 18 :PERSQUEUE DEBUG: read.h:275: [72075186224037896][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-11-26T18:40:55.137729Z node 18 :PERSQUEUE DEBUG: partition.cpp:2112: [72075186224037896][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-11-26T18:40:55.137803Z node 18 :PERSQUEUE DEBUG: partition_write.cpp:570: [72075186224037896][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-11-26T18:40:55.137809Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037896][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.137811Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.137813Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037896][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.137815Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.137819Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037896][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.137824Z node 18 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037896][Partition][0][StateIdle] No data for blobs compaction
2025-11-26T18:40:55.137963Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:398: [PQ: 72075186224037896] 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: "topic2" Version: 0 LocalDC: true RequireAuthWrite: true RequireAuthRead: true Producer: "account@account" Ident: "account@account" Topic: "topic2" DC: "dc1" FormatVersion: 0 Codecs { } TopicPath: "/Root/LbCommunal/account/topic2" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } FederationAccount: "account" AllPartitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } MonitoringProjectId: ""
2025-11-26T18:40:55.137986Z node 18 :PERSQUEUE NOTICE: pq_impl.cpp:911: [PQ: 72075186224037896] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-11-26T18:40:55.138031Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037896] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.139474Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037896] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.139498Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037896] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.140203Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037896] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.143775Z node 18 :KQP_EXECUTER ERROR: kqp_planner.cpp:123: TxId: 281474976720686. Ctx: { TraceId: 01kb0qfwtk6cd48m9feyq8hng2, Database: , SessionId: ydb://session/3?node_id=18&id=ZWU2NDhkMWYtMmZhZTkyNDUtN2VmNmZhZjAtZWNiZjY3NTQ=, PoolId: , DatabaseId: /Root}. Database not set, use /Root
2025-11-26T18:40:55.148327Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037894][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.148340Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.148342Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037894][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.148345Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.148346Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037894][Partition][0][StateIdle] Try persist
===Query complete
Create topic result: 1 
CreateTopicNoLegacy: /Root/LbCommunal/account/topic2-mirrored-from-dc2
Create topic: /Root/LbCommunal/account/topic2-mirrored-from-dc2
AddTopic: /Root/LbCommunal/account/topic2-mirrored-from-dc2
===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/LbCommunal/account/topic2-mirrored-from-dc2, dc = unknown
2025-11-26T18:40:55.150463Z node 18 :PQ_READ_PROXY DEBUG: grpc_pq_schema.cpp:196: new Create topic request
2025-11-26T18:40:55.157107Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2959: [PQ: 72075186224037898] Handle TEvInterconnect::TEvNodeInfo
2025-11-26T18:40:55.157539Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2991: [PQ: 72075186224037898] Transactions request. From tx_00000000000000000000, To tx_18446744073709551615
2025-11-26T18:40:55.157592Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:785: [PQ: 72075186224037898] no config, start with empty partitions and default config
2025-11-26T18:40:55.157606Z node 18 :PERSQUEUE NOTICE: pq_impl.cpp:911: [PQ: 72075186224037898] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-11-26T18:40:55.157634Z node 18 :PERSQUEUE INFO: pq_impl.cpp:612: [PQ: 72075186224037898] doesn't have tx writes info
2025-11-26T18:40:55.157694Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037898] server connected, pipe [18:7577105948546993475:3842], now have 1 active actors on pipe
2025-11-26T18:40:55.157817Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037898] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.158305Z node 19 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1653: [72075186224037899][] pipe [18:7577105948546993476:3843] connected; active server actors: 1
2025-11-26T18:40:55.158415Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer__balancing.cpp:1517: [72075186224037899][topic2-mirrored-from-dc2] updating configuration. Deleted partitions []. Added partitions [0]
2025-11-26T18:40:55.158487Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037898] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.158530Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:969: [72075186224037899][topic2-mirrored-from-dc2] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037899
2025-11-26T18:40:55.158757Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:402: [72075186224037899][topic2-mirrored-from-dc2] TEvClientConnected TabletId 72075186224037898, NodeId 18, Generation 1
2025-11-26T18:40:55.158734Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037898] server connected, pipe [19:7577105949669575438:2386], now have 1 active actors on pipe
2025-11-26T18:40:55.158956Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:138: [72075186224037899][topic2-mirrored-from-dc2] BALANCER INIT DONE for topic2-mirrored-from-dc2: (0, 72075186224037898) 
2025-11-26T18:40:55.160048Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037898] server connected, pipe [18:7577105948546993558:3911], now have 1 active actors on pipe
2025-11-26T18:40:55.160112Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037898] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.160718Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037898] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.161053Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc2--account--topic2:0:Initializer] Start initializing step TInitConfigStep
2025-11-26T18:40:55.161090Z node 18 :PERSQUEUE DEBUG: partition.cpp:1298: [72075186224037898][Partition][0][StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-11-26T18:40:55.161222Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc2--account--topic2:0:Initializer] Start initializing step TInitInternalFieldsStep
2025-11-26T18:40:55.161283Z node 18 :PERSQUEUE INFO: partition_init.cpp:1106: [72075186224037898][Partition][0][StateInit] bootstrapping 0 [18:7577105948546993571:2516]
2025-11-26T18:40:55.161990Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc2--account--topic2:0:Initializer] Start initializing step TInitFieldsStep
2025-11-26T18:40:55.162003Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:61: [rt3.dc2--account--topic2:0:Initializer] Initializing completed.
2025-11-26T18:40:55.162008Z node 18 :PERSQUEUE INFO: partition.cpp:695: [72075186224037898][Partition][0][StateInit] init complete for topic 'rt3.dc2--account--topic2' partition 0 generation 1 [18:7577105948546993571:2516]
2025-11-26T18:40:55.162014Z node 18 :PERSQUEUE DEBUG: partition.cpp:715: [72075186224037898][Partition][0][StateInit] SYNC INIT topic rt3.dc2--account--topic2 partitition 0 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-11-26T18:40:55.162022Z node 18 :PERSQUEUE DEBUG: partition.cpp:4392: [72075186224037898][Partition][0][StateIdle] Process pending events. Count 1
2025-11-26T18:40:55.162028Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037898][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.162032Z node 18 :PERSQUEUE DEBUG: partition.cpp:2375: [72075186224037898][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TTransaction[ProposeConfig])
2025-11-26T18:40:55.162042Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.162044Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037898][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.162046Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.162047Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037898][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.162056Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037898][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.162058Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.162060Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037898][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.162061Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.162063Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037898][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.162167Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037898] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.162199Z node 18 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037898][Partition][0][StateIdle] No data for blobs compaction
2025-11-26T18:40:55.163284Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037898] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.163333Z node 18 :PERSQUEUE DEBUG: partition.cpp:1403: [72075186224037898][Partition][0][StateIdle] Handle TEvPQ::TEvTxCommit Step 1764182455203, TxId 281474976720687
2025-11-26T18:40:55.163432Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037898][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.163449Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.163451Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037898][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.163480Z node 18 :PERSQUEUE DEBUG: partition.cpp:2439: [72075186224037898][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TTransaction[ProposeConfig])
2025-11-26T18:40:55.163509Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-11-26T18:40:55.163511Z node 18 :PERSQUEUE DEBUG: partition.cpp:2301: [72075186224037898][Partition][0][StateIdle] Batch completed (1)
2025-11-26T18:40:55.163513Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037898][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.163567Z node 18 :PERSQUEUE DEBUG: read.h:275: [72075186224037898][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-11-26T18:40:55.164440Z node 18 :PERSQUEUE DEBUG: partition.cpp:2112: [72075186224037898][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-11-26T18:40:55.164506Z node 18 :PERSQUEUE DEBUG: partition_write.cpp:570: [72075186224037898][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-11-26T18:40:55.164518Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037898][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.164520Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.164522Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037898][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.164524Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.164548Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037898][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.164552Z node 18 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037898][Partition][0][StateIdle] No data for blobs compaction
2025-11-26T18:40:55.164681Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:398: [PQ: 72075186224037898] Apply new config PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 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: "topic2-mirrored-from-dc2" Version: 0 LocalDC: false RequireAuthWrite: true RequireAuthRead: true Producer: "account@account" Ident: "account@account" Topic: "topic2" DC: "dc2" FormatVersion: 0 Codecs { } TopicPath: "/Root/LbCommunal/account/topic2-mirrored-from-dc2" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } FederationAccount: "account" AllPartitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } MonitoringProjectId: ""
2025-11-26T18:40:55.164708Z node 18 :PERSQUEUE NOTICE: pq_impl.cpp:911: [PQ: 72075186224037898] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-11-26T18:40:55.164755Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037898] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.165596Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037898] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.165616Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037898] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.166211Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037898] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.177569Z node 18 :KQP_EXECUTER ERROR: kqp_planner.cpp:123: TxId: 281474976720688. Ctx: { TraceId: 01kb0qfwvg1ggag43avys7kv14, Database: , SessionId: ydb://session/3?node_id=18&id=MzcwZmE5OWMtNDE2MzQxYWYtNmQ1YzI4ZjAtMmFkZGZiZjA=, PoolId: , DatabaseId: /Root}. Database not set, use /Root
===Query complete
Create topic result: 1 
2025-11-26T18:40:55.189829Z node 18 :TX_PROXY ERROR: schemereq.cpp:590: Actor# [18:7577105948546993650:3987] txid# 281474976720689, issues: { message: "Check failed: path: \'/Root/LbCommunal\', error: path exist, request accepts it (id: [OwnerId: 72057594046644480, LocalPathId: 11], type: EPathTypeDir, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_mkdir.cpp:155" severity: 1 }
Error 1: Check failed: path: '/Root/LbCommunal', error: path exist, request accepts it (id: [OwnerId: 72057594046644480, LocalPathId: 11], type: EPathTypeDir, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_mkdir.cpp:155
waiting...
CreateTopicNoLegacy: /Root/LbCommunal/account2/topic3
Create topic: /Root/LbCommunal/account2/topic3
AddTopic: /Root/LbCommunal/account2/topic3
===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/LbCommunal/account2/topic3, dc = unknown
2025-11-26T18:40:55.195877Z node 18 :PQ_READ_PROXY DEBUG: grpc_pq_schema.cpp:196: new Create topic request
2025-11-26T18:40:55.204292Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2959: [PQ: 72075186224037900] Handle TEvInterconnect::TEvNodeInfo
2025-11-26T18:40:55.204954Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2991: [PQ: 72075186224037900] Transactions request. From tx_00000000000000000000, To tx_18446744073709551615
2025-11-26T18:40:55.205013Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:785: [PQ: 72075186224037900] no config, start with empty partitions and default config
2025-11-26T18:40:55.205041Z node 18 :PERSQUEUE NOTICE: pq_impl.cpp:911: [PQ: 72075186224037900] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-11-26T18:40:55.205060Z node 18 :PERSQUEUE INFO: pq_impl.cpp:612: [PQ: 72075186224037900] doesn't have tx writes info
2025-11-26T18:40:55.205096Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037900] server connected, pipe [18:7577105948546993762:4074], now have 1 active actors on pipe
2025-11-26T18:40:55.205219Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037900] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.206073Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037900] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.206552Z node 19 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1653: [72075186224037901][] pipe [18:7577105948546993763:4075] connected; active server actors: 1
2025-11-26T18:40:55.210749Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer__balancing.cpp:1517: [72075186224037901][topic3] updating configuration. Deleted partitions []. Added partitions [0]
2025-11-26T18:40:55.211128Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:969: [72075186224037901][topic3] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037901
2025-11-26T18:40:55.214713Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:138: [72075186224037901][topic3] BALANCER INIT DONE for topic3: (0, 72075186224037900) 
2025-11-26T18:40:55.214957Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:402: [72075186224037901][topic3] TEvClientConnected TabletId 72075186224037900, NodeId 18, Generation 1
2025-11-26T18:40:55.214891Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037900] server connected, pipe [19:7577105949669575474:2387], now have 1 active actors on pipe
2025-11-26T18:40:55.216306Z node 18 :KQP_EXECUTER ERROR: kqp_planner.cpp:123: TxId: 281474976720692. Ctx: { TraceId: 01kb0qfwwy5jmrnhj07003eda6, Database: , SessionId: ydb://session/3?node_id=18&id=MTE5OGUxMjctYzVlNTNlZS1hMTYwNDg2NC0yZDIxNjNjOA==, PoolId: , DatabaseId: /Root}. Database not set, use /Root
2025-11-26T18:40:55.216828Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037900] server connected, pipe [18:7577105948546993850:4146], now have 1 active actors on pipe
2025-11-26T18:40:55.216986Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037900] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.218232Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037900] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.218413Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc1--account2--topic3:0:Initializer] Start initializing step TInitConfigStep
2025-11-26T18:40:55.218426Z node 18 :PERSQUEUE DEBUG: partition.cpp:1298: [72075186224037900][Partition][0][StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-11-26T18:40:55.218489Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc1--account2--topic3:0:Initializer] Start initializing step TInitInternalFieldsStep
2025-11-26T18:40:55.218534Z node 18 :PERSQUEUE INFO: partition_init.cpp:1106: [72075186224037900][Partition][0][StateInit] bootstrapping 0 [18:7577105948546993862:2536]
2025-11-26T18:40:55.219374Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc1--account2--topic3:0:Initializer] Start initializing step TInitFieldsStep
2025-11-26T18:40:55.219389Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:61: [rt3.dc1--account2--topic3:0:Initializer] Initializing completed.
2025-11-26T18:40:55.219394Z node 18 :PERSQUEUE INFO: partition.cpp:695: [72075186224037900][Partition][0][StateInit] init complete for topic 'rt3.dc1--account2--topic3' partition 0 generation 1 [18:7577105948546993862:2536]
2025-11-26T18:40:55.219402Z node 18 :PERSQUEUE DEBUG: partition.cpp:715: [72075186224037900][Partition][0][StateInit] SYNC INIT topic rt3.dc1--account2--topic3 partitition 0 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-11-26T18:40:55.219412Z node 18 :PERSQUEUE DEBUG: partition.cpp:4392: [72075186224037900][Partition][0][StateIdle] Process pending events. Count 1
2025-11-26T18:40:55.219419Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037900][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.219424Z node 18 :PERSQUEUE DEBUG: partition.cpp:2375: [72075186224037900][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TTransaction[ProposeConfig])
2025-11-26T18:40:55.219438Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037900][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.219440Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037900][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.219442Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037900][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.219444Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037900][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.219455Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037900][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.219457Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037900][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.219459Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037900][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.219461Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037900][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.219462Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037900][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.219593Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037900] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.219628Z node 18 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037900][Partition][0][StateIdle] No data for blobs compaction
2025-11-26T18:40:55.220452Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037900] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.220489Z node 18 :PERSQUEUE DEBUG: partition.cpp:1403: [72075186224037900][Partition][0][StateIdle] Handle TEvPQ::TEvTxCommit Step 1764182455259, TxId 281474976720691
2025-11-26T18:40:55.220498Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037900][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.220501Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037900][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.220503Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037900][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.220508Z node 18 :PERSQUEUE DEBUG: partition.cpp:2439: [72075186224037900][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TTransaction[ProposeConfig])
2025-11-26T18:40:55.220524Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037900][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-11-26T18:40:55.220526Z node 18 :PERSQUEUE DEBUG: partition.cpp:2301: [72075186224037900][Partition][0][StateIdle] Batch completed (1)
2025-11-26T18:40:55.220528Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037900][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.220561Z node 18 :PERSQUEUE DEBUG: read.h:275: [72075186224037900][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-11-26T18:40:55.220990Z node 18 :PERSQUEUE DEBUG: partition.cpp:2112: [72075186224037900][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-11-26T18:40:55.221054Z node 18 :PERSQUEUE DEBUG: partition_write.cpp:570: [72075186224037900][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-11-26T18:40:55.221065Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037900][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.221067Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037900][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.221069Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037900][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.221071Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037900][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.221072Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037900][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.221077Z node 18 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037900][Partition][0][StateIdle] No data for blobs compaction
2025-11-26T18:40:55.221214Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:398: [PQ: 72075186224037900] 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: "topic3" Version: 0 LocalDC: true RequireAuthWrite: true RequireAuthRead: true Producer: "account2@account2" Ident: "account2@account2" Topic: "topic3" DC: "dc1" FormatVersion: 0 Codecs { } TopicPath: "/Root/LbCommunal/account2/topic3" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } FederationAccount: "account2" AllPartitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } MonitoringProjectId: ""
2025-11-26T18:40:55.221243Z node 18 :PERSQUEUE NOTICE: pq_impl.cpp:911: [PQ: 72075186224037900] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-11-26T18:40:55.221286Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037900] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
===Query complete
2025-11-26T18:40:55.222164Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037900] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.222182Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037900] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.222756Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037900] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
Create topic result: 1 
CreateTopicNoLegacy: /Root/LbCommunal/account2/topic3-mirrored-from-dc2
Create topic: /Root/LbCommunal/account2/topic3-mirrored-from-dc2
AddTopic: /Root/LbCommunal/account2/topic3-mirrored-from-dc2
===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/LbCommunal/account2/topic3-mirrored-from-dc2, dc = unknown
2025-11-26T18:40:55.224027Z node 18 :PQ_READ_PROXY DEBUG: grpc_pq_schema.cpp:196: new Create topic request
2025-11-26T18:40:55.230215Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2959: [PQ: 72075186224037902] Handle TEvInterconnect::TEvNodeInfo
2025-11-26T18:40:55.231379Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2991: [PQ: 72075186224037902] Transactions request. From tx_00000000000000000000, To tx_18446744073709551615
2025-11-26T18:40:55.231432Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:785: [PQ: 72075186224037902] no config, start with empty partitions and default config
2025-11-26T18:40:55.231440Z node 18 :PERSQUEUE NOTICE: pq_impl.cpp:911: [PQ: 72075186224037902] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-11-26T18:40:55.231452Z node 18 :PERSQUEUE INFO: pq_impl.cpp:612: [PQ: 72075186224037902] doesn't have tx writes info
2025-11-26T18:40:55.231526Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037902] server connected, pipe [18:7577105948546993995:4262], now have 1 active actors on pipe
2025-11-26T18:40:55.231760Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037902] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.232534Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037902] server connected, pipe [19:7577105949669575509:2388], now have 1 active actors on pipe
2025-11-26T18:40:55.233131Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037902] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.233833Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.233840Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.233841Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.233845Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.233847Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.234125Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037902] server connected, pipe [18:7577105948546994078:4331], now have 1 active actors on pipe
2025-11-26T18:40:55.234174Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037902] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.234763Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037902] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.234920Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc2--account2--topic3:0:Initializer] Start initializing step TInitConfigStep
2025-11-26T18:40:55.234929Z node 18 :PERSQUEUE DEBUG: partition.cpp:1298: [72075186224037902][Partition][0][StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-11-26T18:40:55.234968Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc2--account2--topic3:0:Initializer] Start initializing step TInitInternalFieldsStep
2025-11-26T18:40:55.235036Z node 18 :PERSQUEUE INFO: partition_init.cpp:1106: [72075186224037902][Partition][0][StateInit] bootstrapping 0 [18:7577105948546994090:2555]
2025-11-26T18:40:55.231621Z node 19 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1653: [72075186224037903][] pipe [18:7577105948546993996:4263] connected; active server actors: 1
2025-11-26T18:40:55.231899Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer__balancing.cpp:1517: [72075186224037903][topic3-mirrored-from-dc2] updating configuration. Deleted partitions []. Added partitions [0]
2025-11-26T18:40:55.232122Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:969: [72075186224037903][topic3-mirrored-from-dc2] Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037903
2025-11-26T18:40:55.232782Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:402: [72075186224037903][topic3-mirrored-from-dc2] TEvClientConnected TabletId 72075186224037902, NodeId 18, Generation 1
2025-11-26T18:40:55.232831Z node 19 :PERSQUEUE_READ_BALANCER DEBUG: read_balancer.cpp:138: [72075186224037903][topic3-mirrored-from-dc2] BALANCER INIT DONE for topic3-mirrored-from-dc2: (0, 72075186224037902) 
2025-11-26T18:40:55.235604Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:81: [rt3.dc2--account2--topic3:0:Initializer] Start initializing step TInitFieldsStep
2025-11-26T18:40:55.235613Z node 18 :PERSQUEUE DEBUG: partition_init.cpp:61: [rt3.dc2--account2--topic3:0:Initializer] Initializing completed.
2025-11-26T18:40:55.235618Z node 18 :PERSQUEUE INFO: partition.cpp:695: [72075186224037902][Partition][0][StateInit] init complete for topic 'rt3.dc2--account2--topic3' partition 0 generation 1 [18:7577105948546994090:2555]
2025-11-26T18:40:55.235625Z node 18 :PERSQUEUE DEBUG: partition.cpp:715: [72075186224037902][Partition][0][StateInit] SYNC INIT topic rt3.dc2--account2--topic3 partitition 0 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-11-26T18:40:55.235633Z node 18 :PERSQUEUE DEBUG: partition.cpp:4392: [72075186224037902][Partition][0][StateIdle] Process pending events. Count 1
2025-11-26T18:40:55.235639Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037902][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.235644Z node 18 :PERSQUEUE DEBUG: partition.cpp:2375: [72075186224037902][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TTransaction[ProposeConfig])
2025-11-26T18:40:55.235660Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037902][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.235661Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037902][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.235672Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037902][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.235679Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037902][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.235685Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037902][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.235687Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037902][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.235688Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037902][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.235690Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037902][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.235691Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037902][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.235749Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037902] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.235768Z node 18 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037902][Partition][0][StateIdle] No data for blobs compaction
2025-11-26T18:40:55.235902Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037896][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.235909Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.235911Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037896][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.235913Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.235915Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037896][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.236603Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037902] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.236636Z node 18 :PERSQUEUE DEBUG: partition.cpp:1403: [72075186224037902][Partition][0][StateIdle] Handle TEvPQ::TEvTxCommit Step 1764182455280, TxId 281474976720693
2025-11-26T18:40:55.236644Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037902][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.236646Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037902][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.236647Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037902][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.236652Z node 18 :PERSQUEUE DEBUG: partition.cpp:2439: [72075186224037902][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TTransaction[ProposeConfig])
2025-11-26T18:40:55.236666Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037902][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-11-26T18:40:55.236668Z node 18 :PERSQUEUE DEBUG: partition.cpp:2301: [72075186224037902][Partition][0][StateIdle] Batch completed (1)
2025-11-26T18:40:55.236671Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037902][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.236702Z node 18 :PERSQUEUE DEBUG: read.h:275: [72075186224037902][PQCacheProxy]CacheProxy. Passthrough write request to KV
2025-11-26T18:40:55.237040Z node 18 :PERSQUEUE DEBUG: partition.cpp:2112: [72075186224037902][Partition][0][StateIdle] Received TEvKeyValue::TEvResponse
2025-11-26T18:40:55.237088Z node 18 :PERSQUEUE DEBUG: partition_write.cpp:570: [72075186224037902][Partition][0][StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-11-26T18:40:55.237097Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037902][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.237099Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037902][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.237100Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037902][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.237102Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037902][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.237104Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037902][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.237108Z node 18 :PERSQUEUE DEBUG: partition_compaction.cpp:183: [72075186224037902][Partition][0][StateIdle] No data for blobs compaction
2025-11-26T18:40:55.237220Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:398: [PQ: 72075186224037902] Apply new config PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 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: "topic3-mirrored-from-dc2" Version: 0 LocalDC: false RequireAuthWrite: true RequireAuthRead: true Producer: "account2@account2" Ident: "account2@account2" Topic: "topic3" DC: "dc2" FormatVersion: 0 Codecs { } TopicPath: "/Root/LbCommunal/account2/topic3-mirrored-from-dc2" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } FederationAccount: "account2" AllPartitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } MonitoringProjectId: ""
2025-11-26T18:40:55.237246Z node 18 :PERSQUEUE NOTICE: pq_impl.cpp:911: [PQ: 72075186224037902] disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-11-26T18:40:55.237293Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037902] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.238339Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037902] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.238362Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:3569: [PQ: 72075186224037902] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-11-26T18:40:55.238892Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:1043: [PQ: 72075186224037902] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-11-26T18:40:55.244702Z node 18 :KQP_EXECUTER ERROR: kqp_planner.cpp:123: TxId: 281474976720694. Ctx: { TraceId: 01kb0qfwxsd39cx0ybhb6qf8yn, Database: , SessionId: ydb://session/3?node_id=18&id=ODE1Mjk4ODUtMTA1YTJkNDItZmQxMjRlYzAtOTQ5MzQwMmQ=, PoolId: , DatabaseId: /Root}. Database not set, use /Root
2025-11-26T18:40:55.248657Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037894][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.248669Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.248671Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037894][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.248674Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.248675Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037894][Partition][0][StateIdle] Try persist
===Query complete
Create topic result: 1 
2025-11-26T18:40:55.258628Z node 18 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976720695: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:690)
2025-11-26T18:40:55.261998Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037898][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.262014Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.262017Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037898][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.262019Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.262022Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037898][Partition][0][StateIdle] Try persist
Create write session
Wait init seqNo
2025-11-26T18:40:55.280576Z node 18 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:107: new grpc connection
2025-11-26T18:40:55.280596Z node 18 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:141: new session created cookie 2
2025-11-26T18:40:55.280757Z node 18 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 2 sessionId:  grpc read done: success: 1 data: init_request { topic: "account/topic2" message_group_id: "test-src" }
2025-11-26T18:40:55.280798Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:447: session request cookie: 2 topic: "account/topic2" message_group_id: "test-src" from ipv6:[::1]:37164
2025-11-26T18:40:55.280809Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:1538: write session:  cookie=2 sessionId= userAgent="pqv1 server" ip=ipv6:[::1]:37164 proto=v1  topic=account/topic2 durationSec=0
2025-11-26T18:40:55.280813Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:571: init check schema
2025-11-26T18:40:55.280829Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:455: Handle describe topics
2025-11-26T18:40:55.280837Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:506: SendSchemeCacheRequest
2025-11-26T18:40:55.280855Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:541: send request for 1 topics, got 1 requests infly, db = ""
2025-11-26T18:40:55.281167Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:548: Handle SchemeCache response: result# { ErrorCount: 1 DatabaseName:  DomainOwnerId: 0 Instant: 3 ResultSet [{ Path: Root/PQ/rt3.dc1--account--topic2 TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpList RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: PathErrorUnknown Kind: KindUnknown DomainInfo <null> }] }
2025-11-26T18:40:55.281179Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:506: SendSchemeCacheRequest
2025-11-26T18:40:55.281187Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:541: send request for 1 topics, got 1 requests infly, db = "/Root/LbCommunal/account"
2025-11-26T18:40:55.281727Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:548: Handle SchemeCache response: result# { ErrorCount: 0 DatabaseName: /Root/LbCommunal/account DomainOwnerId: 0 Instant: 4 ResultSet [{ Path: Root/LbCommunal/account/topic2 TableId: [72057594046644480:13:0] RequestType: ByPath Operation: OpList RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: Ok Kind: KindTopic DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) Users: [] Groups: [] } }] }
2025-11-26T18:40:55.281760Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:613: Got describe topics SC response
2025-11-26T18:40:55.282103Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:632: session v1 cookie: 2 sessionId:  describe result for acl check
2025-11-26T18:40:55.282152Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__table_helper.h:62: TTableHelper SelectQuery: --!syntax_v1
DECLARE $Hash AS Uint32; DECLARE $Topic AS Utf8; DECLARE $SourceId AS Utf8;
SELECT Partition, CreateTime, AccessTime, SeqNo FROM `/Root/PQ/SourceIdMeta2` WHERE Hash == $Hash AND Topic == $Topic AND SourceId == $SourceId;
2025-11-26T18:40:55.282154Z node 18 :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 Uint32; DECLARE $Partition AS Uint32; DECLARE $CreateTime AS Uint64; DECLARE $AccessTime AS Uint64;DECLARE $SeqNo AS Uint64;
UPSERT INTO `/Root/PQ/SourceIdMeta2` (Hash, Topic, SourceId, CreateTime, AccessTime, Partition, SeqNo) VALUES ($Hash, $Topic, $SourceId, $CreateTime, $AccessTime, $Partition, $SeqNo);
2025-11-26T18:40:55.282155Z node 18 :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 Uint32; DECLARE $Partition AS Uint32; DECLARE $CreateTime AS Uint64; DECLARE $AccessTime AS Uint64;
UPDATE `/Root/PQ/SourceIdMeta2` SET AccessTime = $AccessTime WHERE Hash = $Hash AND Topic = $Topic AND SourceId = $SourceId AND Partition = $Partition;
2025-11-26T18:40:55.282161Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:111: TPartitionChooser [18:7577105948546994349:2584] (SourceId=test-src, PreferedPartition=(NULL)) StartKqpSession
2025-11-26T18:40:55.282931Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:142: TPartitionChooser [18:7577105948546994349:2584] (SourceId=test-src, PreferedPartition=(NULL)) Select from the table
2025-11-26T18:40:55.287064Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__old_chooser_actor.h:67: TPartitionChooser [18:7577105948546994349:2584] (SourceId=test-src, PreferedPartition=(NULL)) RequestPQRB
2025-11-26T18:40:55.287275Z node 19 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1653: [72075186224037897][topic2] pipe [18:7577105948546994365:2584] connected; active server actors: 1
2025-11-26T18:40:55.287428Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__old_chooser_actor.h:80: TPartitionChooser [18:7577105948546994349:2584] (SourceId=test-src, PreferedPartition=(NULL)) Received partition 0 from PQRB for SourceId=test-src
2025-11-26T18:40:55.287446Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:174: TPartitionChooser [18:7577105948546994349:2584] (SourceId=test-src, PreferedPartition=(NULL)) Update the table
2025-11-26T18:40:55.287579Z node 19 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1665: [72075186224037897][topic2] pipe [18:7577105948546994365:2584] disconnected; active server actors: 1
2025-11-26T18:40:55.287588Z node 19 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1689: [72075186224037897][topic2] pipe [18:7577105948546994365:2584] disconnected no session
2025-11-26T18:40:55.290199Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:183: TPartitionChooser [18:7577105948546994349:2584] (SourceId=test-src, PreferedPartition=(NULL)) HandleUpdate PartitionPersisted=0 Status=SUCCESS
2025-11-26T18:40:55.290215Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:305: TPartitionChooser [18:7577105948546994349:2584] (SourceId=test-src, PreferedPartition=(NULL)) ReplyResult: Partition=0, SeqNo=(NULL)
2025-11-26T18:40:55.290219Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:268: TPartitionChooser [18:7577105948546994349:2584] (SourceId=test-src, PreferedPartition=(NULL)) Start idle
2025-11-26T18:40:55.290229Z node 18 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:694: ProceedPartition. session cookie: 2 sessionId:  partition: 0 expectedGeneration: (NULL)
2025-11-26T18:40:55.290416Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037896] server connected, pipe [18:7577105948546994376:2584], now have 1 active actors on pipe
2025-11-26T18:40:55.290425Z node 18 :PQ_WRITE_PROXY DEBUG: writer.cpp:822: TPartitionWriter 72075186224037896 (partition=0) TEvClientConnected Status OK, TabletId: 72075186224037896, NodeId 18, Generation: 1
2025-11-26T18:40:55.290441Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic2' requestId: <none>
2025-11-26T18:40:55.290448Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037896] got client message batch for topic 'rt3.dc1--account--topic2' partition 0
2025-11-26T18:40:55.290477Z node 18 :PERSQUEUE INFO: ownerinfo.cpp:30: new Cookie test-src|e8539f87-f028c4c9-ef1fc0ff-abc8bf30_0 generated for partition 0 topic 'rt3.dc1--account--topic2' owner test-src
2025-11-26T18:40:55.290486Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037896][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.290490Z node 18 :PERSQUEUE DEBUG: partition.cpp:2382: [72075186224037896][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-11-26T18:40:55.290496Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.290498Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037896][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.290503Z node 18 :PERSQUEUE DEBUG: partition.cpp:2446: [72075186224037896][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-11-26T18:40:55.290512Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-11-26T18:40:55.290514Z node 18 :PERSQUEUE DEBUG: partition.cpp:2301: [72075186224037896][Partition][0][StateIdle] Batch completed (1)
2025-11-26T18:40:55.290518Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037896][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.290533Z node 18 :PERSQUEUE DEBUG: partition_write.cpp:35: [72075186224037896][Partition][0][StateIdle] TPartition::ReplyOwnerOk. Partition: 0
2025-11-26T18:40:55.290556Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic2' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-11-26T18:40:55.290629Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'topic2' requestId: <none>
2025-11-26T18:40:55.290640Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037896] got client message batch for topic 'rt3.dc1--account--topic2' partition 0
2025-11-26T18:40:55.290654Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'topic2' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-11-26T18:40:55.290687Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:871: session inited cookie: 2 partition: 0 MaxSeqNo: 0 sessionId: test-src|e8539f87-f028c4c9-ef1fc0ff-abc8bf30_0
Wait init seqNo(2)
2025-11-26T18:40:55.291566Z node 18 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 2 sessionId: test-src|e8539f87-f028c4c9-ef1fc0ff-abc8bf30_0 grpc read done: success: 0 data: 
2025-11-26T18:40:55.291581Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:256: session v1 cookie: 2 sessionId: test-src|e8539f87-f028c4c9-ef1fc0ff-abc8bf30_0 grpc read failed
2025-11-26T18:40:55.291588Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:232: session v1 cookie: 2 sessionId: test-src|e8539f87-f028c4c9-ef1fc0ff-abc8bf30_0 grpc closed
2025-11-26T18:40:55.291594Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:304: session v1 cookie: 2 sessionId: test-src|e8539f87-f028c4c9-ef1fc0ff-abc8bf30_0 is DEAD
2025-11-26T18:40:55.291889Z node 18 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037896 (partition=0) Received event: NActors::TEvents::TEvPoison
2025-11-26T18:40:55.291945Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2745: [PQ: 72075186224037896] server disconnected, pipe [18:7577105948546994376:2584] destroyed
2025-11-26T18:40:55.291960Z node 18 :PERSQUEUE DEBUG: partition_write.cpp:138: [72075186224037896][Partition][0][StateIdle] TPartition::DropOwner.
2025-11-26T18:40:55.291964Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037896][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.291968Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.291970Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037896][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.291972Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.291974Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037896][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.292616Z node 18 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:107: new grpc connection
2025-11-26T18:40:55.292629Z node 18 :PQ_WRITE_PROXY DEBUG: grpc_pq_write.h:141: new session created cookie 3
2025-11-26T18:40:55.292768Z node 18 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 3 sessionId:  grpc read done: success: 1 data: init_request { topic: "account/topic1" message_group_id: "test-src" }
2025-11-26T18:40:55.292801Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:447: session request cookie: 3 topic: "account/topic1" message_group_id: "test-src" from ipv6:[::1]:37164
2025-11-26T18:40:55.292806Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:1538: write session:  cookie=3 sessionId= userAgent="pqv1 server" ip=ipv6:[::1]:37164 proto=v1  topic=account/topic1 durationSec=0
2025-11-26T18:40:55.292810Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:571: init check schema
2025-11-26T18:40:55.292824Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:455: Handle describe topics
2025-11-26T18:40:55.292828Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:506: SendSchemeCacheRequest
2025-11-26T18:40:55.292841Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:541: send request for 1 topics, got 1 requests infly, db = ""
2025-11-26T18:40:55.293060Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:548: Handle SchemeCache response: result# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 5 ResultSet [{ Path: Root/PQ/rt3.dc1--account--topic1 TableId: [72057594046644480:10:0] RequestType: ByPath Operation: OpList RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: Ok Kind: KindTopic DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) Users: [] Groups: [] } }] }
2025-11-26T18:40:55.293096Z node 18 :PQ_METACACHE DEBUG: msgbus_server_pq_metacache.cpp:613: Got describe topics SC response
2025-11-26T18:40:55.293356Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:632: session v1 cookie: 3 sessionId:  describe result for acl check
2025-11-26T18:40:55.293387Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__table_helper.h:62: TTableHelper SelectQuery: --!syntax_v1
DECLARE $Hash AS Uint32; DECLARE $Topic AS Utf8; DECLARE $SourceId AS Utf8;
SELECT Partition, CreateTime, AccessTime, SeqNo FROM `/Root/PQ/SourceIdMeta2` WHERE Hash == $Hash AND Topic == $Topic AND SourceId == $SourceId;
2025-11-26T18:40:55.293393Z node 18 :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 Uint32; DECLARE $Partition AS Uint32; DECLARE $CreateTime AS Uint64; DECLARE $AccessTime AS Uint64;DECLARE $SeqNo AS Uint64;
UPSERT INTO `/Root/PQ/SourceIdMeta2` (Hash, Topic, SourceId, CreateTime, AccessTime, Partition, SeqNo) VALUES ($Hash, $Topic, $SourceId, $CreateTime, $AccessTime, $Partition, $SeqNo);
2025-11-26T18:40:55.293395Z node 18 :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 Uint32; DECLARE $Partition AS Uint32; DECLARE $CreateTime AS Uint64; DECLARE $AccessTime AS Uint64;
UPDATE `/Root/PQ/SourceIdMeta2` SET AccessTime = $AccessTime WHERE Hash = $Hash AND Topic = $Topic AND SourceId = $SourceId AND Partition = $Partition;
2025-11-26T18:40:55.293399Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:111: TPartitionChooser [18:7577105948546994380:2594] (SourceId=test-src, PreferedPartition=(NULL)) StartKqpSession
2025-11-26T18:40:55.293832Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:142: TPartitionChooser [18:7577105948546994380:2594] (SourceId=test-src, PreferedPartition=(NULL)) Select from the table
2025-11-26T18:40:55.295604Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__old_chooser_actor.h:67: TPartitionChooser [18:7577105948546994380:2594] (SourceId=test-src, PreferedPartition=(NULL)) RequestPQRB
2025-11-26T18:40:55.295811Z node 19 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1653: [72075186224037895][rt3.dc1--account--topic1] pipe [18:7577105948546994396:2594] connected; active server actors: 1
2025-11-26T18:40:55.295962Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__old_chooser_actor.h:80: TPartitionChooser [18:7577105948546994380:2594] (SourceId=test-src, PreferedPartition=(NULL)) Received partition 0 from PQRB for SourceId=test-src
2025-11-26T18:40:55.295975Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:174: TPartitionChooser [18:7577105948546994380:2594] (SourceId=test-src, PreferedPartition=(NULL)) Update the table
2025-11-26T18:40:55.296217Z node 19 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1665: [72075186224037895][rt3.dc1--account--topic1] pipe [18:7577105948546994396:2594] disconnected; active server actors: 1
2025-11-26T18:40:55.296227Z node 19 :PERSQUEUE_READ_BALANCER INFO: read_balancer__balancing.cpp:1689: [72075186224037895][rt3.dc1--account--topic1] pipe [18:7577105948546994396:2594] disconnected no session
2025-11-26T18:40:55.299657Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:183: TPartitionChooser [18:7577105948546994380:2594] (SourceId=test-src, PreferedPartition=(NULL)) HandleUpdate PartitionPersisted=0 Status=SUCCESS
2025-11-26T18:40:55.299678Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:305: TPartitionChooser [18:7577105948546994380:2594] (SourceId=test-src, PreferedPartition=(NULL)) ReplyResult: Partition=0, SeqNo=(NULL)
2025-11-26T18:40:55.299682Z node 18 :PQ_PARTITION_CHOOSER DEBUG: partition_chooser_impl__abstract_chooser_actor.h:268: TPartitionChooser [18:7577105948546994380:2594] (SourceId=test-src, PreferedPartition=(NULL)) Start idle
2025-11-26T18:40:55.299691Z node 18 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:694: ProceedPartition. session cookie: 3 sessionId:  partition: 0 expectedGeneration: (NULL)
2025-11-26T18:40:55.300294Z node 18 :PQ_WRITE_PROXY DEBUG: writer.cpp:822: TPartitionWriter 72075186224037894 (partition=0) TEvClientConnected Status OK, TabletId: 72075186224037894, NodeId 18, Generation: 1
2025-11-26T18:40:55.300320Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2720: [PQ: 72075186224037894] server connected, pipe [18:7577105948546994406:2594], now have 1 active actors on pipe
2025-11-26T18:40:55.300328Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'rt3.dc1--account--topic1' requestId: <none>
2025-11-26T18:40:55.300336Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037894] got client message batch for topic 'rt3.dc1--account--topic1' partition 0
2025-11-26T18:40:55.300365Z node 18 :PERSQUEUE INFO: ownerinfo.cpp:30: new Cookie test-src|2ea123ff-a7782ccf-e26d69c9-9505c0d7_0 generated for partition 0 topic 'rt3.dc1--account--topic1' owner test-src
2025-11-26T18:40:55.300383Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037894][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.300387Z node 18 :PERSQUEUE DEBUG: partition.cpp:2382: [72075186224037894][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxEvent(TMessage)
2025-11-26T18:40:55.300392Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 1, PendingWrites: 0
2025-11-26T18:40:55.300402Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037894][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.300406Z node 18 :PERSQUEUE DEBUG: partition.cpp:2446: [72075186224037894][Partition][0][StateIdle] TPartition::ProcessUserActionAndTxPendingCommit(TMessage)
2025-11-26T18:40:55.300416Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 1
2025-11-26T18:40:55.300419Z node 18 :PERSQUEUE DEBUG: partition.cpp:2301: [72075186224037894][Partition][0][StateIdle] Batch completed (1)
2025-11-26T18:40:55.300422Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037894][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.300440Z node 18 :PERSQUEUE DEBUG: partition_write.cpp:35: [72075186224037894][Partition][0][StateIdle] TPartition::ReplyOwnerOk. Partition: 0
2025-11-26T18:40:55.300465Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'rt3.dc1--account--topic1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-11-26T18:40:55.300526Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:146: Handle TEvRequest topic: 'rt3.dc1--account--topic1' requestId: <none>
2025-11-26T18:40:55.300535Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2634: [PQ: 72075186224037894] got client message batch for topic 'rt3.dc1--account--topic1' partition 0
2025-11-26T18:40:55.300547Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:181: Answer ok topic: 'rt3.dc1--account--topic1' partition: 0 messageNo: 0  requestId: <none> cookie: 0
2025-11-26T18:40:55.300576Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:871: session inited cookie: 3 partition: 0 MaxSeqNo: 0 sessionId: test-src|2ea123ff-a7782ccf-e26d69c9-9505c0d7_0
2025-11-26T18:40:55.301303Z node 18 :PQ_WRITE_PROXY DEBUG: write_session_actor.cpp:254: session v1 cookie: 3 sessionId: test-src|2ea123ff-a7782ccf-e26d69c9-9505c0d7_0 grpc read done: success: 0 data: 
2025-11-26T18:40:55.301317Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:256: session v1 cookie: 3 sessionId: test-src|2ea123ff-a7782ccf-e26d69c9-9505c0d7_0 grpc read failed
2025-11-26T18:40:55.301325Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:232: session v1 cookie: 3 sessionId: test-src|2ea123ff-a7782ccf-e26d69c9-9505c0d7_0 grpc closed
2025-11-26T18:40:55.301330Z node 18 :PQ_WRITE_PROXY INFO: write_session_actor.cpp:304: session v1 cookie: 3 sessionId: test-src|2ea123ff-a7782ccf-e26d69c9-9505c0d7_0 is DEAD
2025-11-26T18:40:55.301679Z node 18 :PQ_WRITE_PROXY DEBUG: writer.cpp:562: TPartitionWriter 72075186224037894 (partition=0) Received event: NActors::TEvents::TEvPoison
2025-11-26T18:40:55.301733Z node 18 :PERSQUEUE DEBUG: pq_impl.cpp:2745: [PQ: 72075186224037894] server disconnected, pipe [18:7577105948546994406:2594] destroyed
2025-11-26T18:40:55.301749Z node 18 :PERSQUEUE DEBUG: partition_write.cpp:138: [72075186224037894][Partition][0][StateIdle] TPartition::DropOwner.
2025-11-26T18:40:55.301755Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037894][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.301757Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.301759Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037894][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.301761Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.301762Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037894][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.319881Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037900][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.319904Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037900][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.319907Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037900][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.319912Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037900][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.319915Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037900][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.334203Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.334225Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.334227Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.334232Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.334234Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.335723Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037902][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.335742Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037902][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.335744Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037902][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.335747Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037902][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.335750Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037902][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.336175Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037896][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.336184Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.336185Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037896][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.336187Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.336189Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037896][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.349060Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037894][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.349081Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.349084Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037894][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.349088Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.349091Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037894][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.362357Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037898][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.362384Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.362387Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037898][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.362391Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.362394Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037898][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.420218Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037900][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.420246Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037900][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.420248Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037900][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.420252Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037900][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.420254Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037900][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.434560Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.434593Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.434595Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.434599Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.434602Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.436090Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037902][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.436106Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037902][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.436112Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037902][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.436115Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037902][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.436117Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037902][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.436578Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037896][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.436589Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.436591Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037896][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.436593Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.436595Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037896][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.449426Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037894][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.449448Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.449452Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037894][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.449469Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.449472Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037894][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.462710Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037898][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.462733Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.462735Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037898][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.462744Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.462747Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037898][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.520574Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037900][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.520597Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037900][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.520600Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037900][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.520604Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037900][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.520606Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037900][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.534932Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037892][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.534956Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.534959Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037892][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.534963Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037892][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.534966Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037892][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.536439Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037902][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.536453Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037902][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.536457Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037902][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.536459Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037902][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.536465Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037902][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.536946Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037896][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.536960Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.536962Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037896][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.536964Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037896][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.536966Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037896][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.549741Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037894][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.549784Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.549787Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037894][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.549790Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037894][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.549792Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037894][Partition][0][StateIdle] Try persist
2025-11-26T18:40:55.563073Z node 18 :PERSQUEUE DEBUG: partition.cpp:2288: [72075186224037898][Partition][0][StateIdle] Process user action and tx events
2025-11-26T18:40:55.563096Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.563099Z node 18 :PERSQUEUE DEBUG: partition.cpp:2296: [72075186224037898][Partition][0][StateIdle] Process user action and tx pending commits
2025-11-26T18:40:55.563103Z node 18 :PERSQUEUE DEBUG: partition.cpp:2347: [72075186224037898][Partition][0][StateIdle] Events: 0, PendingCommits: 0, PendingWrites: 0
2025-11-26T18:40:55.563105Z node 18 :PERSQUEUE DEBUG: partition.cpp:2306: [72075186224037898][Partition][0][StateIdle] Try persist
