2025-10-26T18:05:43.388471Z node 3 :METADATA_PROVIDER WARN: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[3:7565593240541621566:4098];send_to=[0:7307199536658146131:7762515];
2025-10-26T18:05:43.395769Z node 3 :METADATA_PROVIDER ERROR: fline=accessor_snapshot_base.cpp:68;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=scheme_cache_undelivered_message;
2025-10-26T18:05:43.415292Z node 4 :METADATA_PROVIDER WARN: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[4:7565593237748609638:4098];send_to=[0:7307199536658146131:7762515];
2025-10-26T18:05:43.418139Z node 4 :PQ_READ_PROXY DEBUG: Direct read cache created
2025-10-26T18:05:43.418682Z node 4 :METADATA_PROVIDER ERROR: fline=accessor_snapshot_base.cpp:68;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=scheme_cache_undelivered_message;
2025-10-26T18:05:43.455265Z node 3 :PQ_READ_PROXY DEBUG: Direct read cache created
test_client.cpp: SetPath # /home/runner/.ya/build/build_root/70hy/000519/r3tmp/tmpU8Llfl/pdisk_1.dat
2025-10-26T18:05:43.679118Z node 3 :IMPORT WARN: Table profiles were not loaded
2025-10-26T18:05:43.722056Z node 3 :HIVE WARN: HIVE#72057594037968897 Node(3, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-10-26T18:05:43.722155Z node 3 :HIVE WARN: HIVE#72057594037968897 Node(3, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-10-26T18:05:43.723438Z node 3 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-10-26T18:05:43.723506Z node 3 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-10-26T18:05:43.725462Z node 3 :HIVE WARN: HIVE#72057594037968897 Node(3, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-10-26T18:05:43.728088Z node 3 :HIVE WARN: HIVE#72057594037968897 Handle TEvInterconnect::TEvNodeConnected, NodeId 4 Cookie 4
2025-10-26T18:05:43.729654Z node 3 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Connecting -> Connected
TServer::EnableGrpc on GrpcPort 28179, node 3
2025-10-26T18:05:43.792009Z node 3 :NET_CLASSIFIER WARN: distributable config is empty, broken or outdated, will use file: /home/runner/.ya/build/build_root/70hy/000519/r3tmp/yandexyLRK4U.tmp
2025-10-26T18:05:43.792034Z node 3 :NET_CLASSIFIER WARN: will try to initialize from file: /home/runner/.ya/build/build_root/70hy/000519/r3tmp/yandexyLRK4U.tmp
2025-10-26T18:05:43.792160Z node 3 :NET_CLASSIFIER WARN: successfully initialized from file: /home/runner/.ya/build/build_root/70hy/000519/r3tmp/yandexyLRK4U.tmp
2025-10-26T18:05:43.792278Z node 3 :NET_CLASSIFIER ERROR: got bad distributable configuration
2025-10-26T18:05:43.838396Z INFO: TTestServer started on Port 5406 GrpcPort 28179
TClient is connected to server localhost:5406
PQClient connected to localhost:28179
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
    }
  }
  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
      PlanResolution: 7
      Coo...
(TRUNCATED)
WaitRootIsUp 'Root' success.
2025-10-26T18:05:44.070073Z node 3 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 281474976715657:0, at schemeshard:  72057594046644480
waiting...
waiting...
2025-10-26T18:05:44.129573Z node 3 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976715659:0, at schemeshard:  72057594046644480
waiting...
waiting...
waiting...
2025-10-26T18:05:44.315943Z node 3 :FLAT_TX_SCHEMESHARD WARN: NotifyTxCompletion, unknown transaction, txId: 281474976715661, at schemeshard: 72057594046644480
2025-10-26T18:05:46.792846Z node 4 :KQP_COMPILE_ACTOR ERROR: Compilation failed, self: [4:7565593250633511861:4292], status: SCHEME_ERROR, issues: <main>: Error: Type annotation, code: 1030
    <main>:3:16: Error: At function: KiReadTable!
        <main>:3:16: Error: Cannot find table 'db.[/Root/PQ/Config/V2/Cluster]' because it does not exist or you do not have access permissions. Please check correctness of table path and user permissions., code: 2003
2025-10-26T18:05:46.795093Z node 4 :KQP_SESSION WARN: SessionId: ydb://session/3?node_id=4&id=MjJlNDQ0MGUtZmNhNjg0NDEtNjU0ZjNiMTYtMTY3MjFlM2Q=, ActorId: [4:7565593250633511859:4295], ActorState: ExecuteState, TraceId: 01k8gv58w84abkwck4mck1hw9m, ReplyQueryCompileError, status SCHEME_ERROR remove tx with tx_id: 
2025-10-26T18:05:46.796137Z node 4 :PERSQUEUE_CLUSTER_TRACKER ERROR: failed to list clusters: { Response { QueryIssues { message: "Type annotation" issue_code: 1030 severity: 1 issues { position { row: 3 column: 16 } message: "At function: KiReadTable!" end_position { row: 3 column: 16 } severity: 1 issues { position { row: 3 column: 16 } message: "Cannot find table \'db.[/Root/PQ/Config/V2/Cluster]\' because it does not exist or you do not have access permissions. Please check correctness of table path and user permissions." end_position { row: 3 column: 16 } issue_code: 2003 severity: 1 } } } TxMeta { } } YdbStatus: SCHEME_ERROR ConsumedRu: 1 }
2025-10-26T18:05:46.847640Z node 3 :KQP_COMPILE_ACTOR ERROR: Compilation failed, self: [3:7565593253426524473:4297], status: SCHEME_ERROR, issues: <main>: Error: Type annotation, code: 1030
    <main>:3:16: Error: At function: KiReadTable!
        <main>:3:16: Error: Cannot find table 'db.[/Root/PQ/Config/V2/Cluster]' because it does not exist or you do not have access permissions. Please check correctness of table path and user permissions., code: 2003
2025-10-26T18:05:46.851499Z node 3 :KQP_SESSION WARN: SessionId: ydb://session/3?node_id=3&id=NTUwZmY2YTUtNDk3OTdmOTItOGM5YmI2MzYtMTVmMTExMjQ=, ActorId: [3:7565593253426524470:4284], ActorState: ExecuteState, TraceId: 01k8gv58xs8yzqkpz7v6bbckem, ReplyQueryCompileError, status SCHEME_ERROR remove tx with tx_id: 
2025-10-26T18:05:46.852316Z node 3 :PERSQUEUE_CLUSTER_TRACKER ERROR: failed to list clusters: { Response { QueryIssues { message: "Type annotation" issue_code: 1030 severity: 1 issues { position { row: 3 column: 16 } message: "At function: KiReadTable!" end_position { row: 3 column: 16 } severity: 1 issues { position { row: 3 column: 16 } message: "Cannot find table \'db.[/Root/PQ/Config/V2/Cluster]\' because it does not exist or you do not have access permissions. Please check correctness of table path and user permissions." end_position { row: 3 column: 16 } issue_code: 2003 severity: 1 } } } TxMeta { } } YdbStatus: SCHEME_ERROR ConsumedRu: 1 }
2025-10-26T18:05:46.863788Z node 3 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976715662:0, at schemeshard:  72057594046644480
2025-10-26T18:05:46.955382Z node 3 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976715663:0, at schemeshard:  72057594046644480
2025-10-26T18:05:47.106659Z node 3 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976715664:0, at schemeshard:  72057594046644480
=== Init DC: UPSERT INTO `/Root/PQ/Config/V2/Cluster` (name, balancer, local, enabled, weight) VALUES ("dc1", "localhost", true, true, 1000), ("dc2", "dc2.logbroker.yandex.net", false, true, 1000);
2025-10-26T18:05:47.409269Z node 3 :KQP_EXECUTER ERROR: TxId: 281474976715665. Ctx: { TraceId: 01k8gv59a24efyhp30htvssrc2, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=3&id=M2MyNTA3OGMtODBiYzExYy1hYmRjZTU0MC0xMjc4M2Ni, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
=== CheckClustersList. Subcribe to ClusterTracker from [3:7565593257721492191:12348] 
2025-10-26T18:05:48.388971Z node 3 :METADATA_PROVIDER ERROR: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[3:7565593240541621566:4098];send_to=[0:7307199536658146131:7762515];
2025-10-26T18:05:48.389061Z node 3 :METADATA_PROVIDER ERROR: fline=accessor_snapshot_base.cpp:68;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=timeout;
2025-10-26T18:05:48.418017Z node 4 :METADATA_PROVIDER ERROR: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[4:7565593237748609638:4098];send_to=[0:7307199536658146131:7762515];
2025-10-26T18:05:48.418107Z node 4 :METADATA_PROVIDER ERROR: fline=accessor_snapshot_base.cpp:68;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=timeout;
=== CheckClustersList. Ok
PQ Client: create topic: rt3.dc1--topic1 with 10 partitions
CallPersQueueGRPC request to localhost:28179
MetaRequest {
  CmdGetTopicMetadata {
    Topic: "rt3.dc1--topic1"
  }
}
2025-10-26T18:05:53.395964Z node 3 :PERSQUEUE INFO: proxy answer <none>
CallPersQueueGRPC response:
Status: 128
ErrorReason: "the following topics are not created: rt3.dc1--topic1, Marker# PQ95"
ErrorCode: UNKNOWN_TOPIC
CallPersQueueGRPC request to localhost:28179
MetaRequest {
  CmdCreateTopic {
    Topic: "rt3.dc1--topic1"
    NumPartitions: 10
    Config {
      PartitionConfig {
        LifetimeSeconds: 86400
        LowWatermark: 8388608
        SourceIdLifetimeSeconds: 86400
        WriteSpeedInBytesPerSecond: 20000000
        BurstSize: 20000000
        SourceIdMaxCounts: 6000000
      }
      LocalDC: true
      ReadRules: "user"
      ReadFromTimestampsMs: 0
      ConsumerFormatVersions: 0
      ConsumerCodecs {
      }
      Codecs {
        Ids: 0
        Ids: 1
        Ids: 2
        Codecs: "raw"
        Codecs: "gzip"
        Codecs: "lzop"
      }
      ReadRuleVersions: 0
    }
  }
}
CallPersQueueGRPC response:
Status: 129
ProxyErrorCode: 53
SchemeStatus: 1
FlatTxId {
  TxId: 281474976715677
  SchemeShardTabletId: 72057594046644480
  PathId: 9
}
ErrorCode: OK
AddTopic: rt3.dc1--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 = topic1, dc = dc1
2025-10-26T18:05:53.485037Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvInterconnect::TEvNodeInfo
2025-10-26T18:05:53.485473Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Registered with mediator time cast
2025-10-26T18:05:53.490087Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Transactions request. From tx_00000000000000000000, To tx_18446744073709551615
2025-10-26T18:05:53.490357Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvInterconnect::TEvNodeInfo
2025-10-26T18:05:53.490398Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] doesn't have tx info
2025-10-26T18:05:53.490425Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] PlanStep 0, PlanTxId 0, ExecStep 0, ExecTxId 0
2025-10-26T18:05:53.490451Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] no config, start with empty partitions and default config
2025-10-26T18:05:53.490476Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Txs.size=0, PlannedTxs.size=0
2025-10-26T18:05:53.490502Z node 3 :PERSQUEUE NOTICE: Tablet 72075186224037893 disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-10-26T18:05:53.490541Z node 3 :PERSQUEUE INFO: Tablet 72075186224037893 doesn't have tx writes info
2025-10-26T18:05:53.491666Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Registered with mediator time cast
2025-10-26T18:05:53.492688Z node 4 :PERSQUEUE_READ_BALANCER INFO: balancer: [72075186224037894] topic  pipe [3:7565593283491296576:8324] connected; active server actors: 1
2025-10-26T18:05:53.492818Z node 3 :PERSQUEUE DEBUG: Tablet 72075186224037893 server connected, pipe [3:7565593283491296575:8503], now have 1 active actors on pipe
2025-10-26T18:05:53.493601Z node 4 :PERSQUEUE_READ_BALANCER DEBUG: balancer: [72075186224037894] topic rt3.dc1--topic1 updating configuration. Deleted partitions []. Added partitions [3, 0, 1, 6, 8, 9, 2, 5, 7, 4]
2025-10-26T18:05:53.493265Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPersQueue::TEvProposeTransaction SourceActor { RawX1: 7565593240541621903 RawX2: 12884914235 } TxId: 281474976715677 Config { TabletConfig { PartitionConfig { LifetimeSeconds: 86400 LowWatermark: 8388608 SourceIdLifetimeSeconds: 86400 WriteSpeedInBytesPerSecond: 20000000 BurstSize: 20000000 TotalPartitions: 10 SourceIdMaxCounts: 6000000 } PartitionIds: 9 PartitionIds: 2 PartitionIds: 5 PartitionIds: 7 PartitionIds: 4 TopicName: "rt3.dc1--topic1" Version: 0 LocalDC: true ReadRules: "user" ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } Codecs { Ids: 0 Ids: 1 Ids: 2 Codecs: "raw" Codecs: "gzip" Codecs: "lzop" } ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 9 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 2 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 5 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 7 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 4 Status: Active CreateVersion: 1 TabletId: 0 } } }
2025-10-26T18:05:53.493361Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Propose TxId 281474976715677, WriteId (empty maybe)
2025-10-26T18:05:53.493385Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state UNKNOWN
2025-10-26T18:05:53.493402Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State UNKNOWN
2025-10-26T18:05:53.493420Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] schedule TEvProposeTransactionResult(PREPARED)
2025-10-26T18:05:53.493442Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, NewState PREPARING
2025-10-26T18:05:53.493477Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] write key for TxId 281474976715677
2025-10-26T18:05:53.494069Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] save tx TxId: 281474976715677 State: PREPARED MinStep: 1761501953519 MaxStep: 18446744073709551615 Kind: KIND_CONFIG TabletConfig { PartitionConfig { LifetimeSeconds: 86400 LowWatermark: 8388608 SourceIdLifetimeSeconds: 86400 WriteSpeedInBytesPerSecond: 20000000 BurstSize: 20000000 TotalPartitions: 10 SourceIdMaxCounts: 6000000 } PartitionIds: 9 PartitionIds: 2 PartitionIds: 5 PartitionIds: 7 PartitionIds: 4 TopicName: "rt3.dc1--topic1" Version: 0 LocalDC: true ReadRules: "user" ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } Codecs { Ids: 0 Ids: 1 Ids: 2 Codecs: "raw" Codecs: "gzip" Codecs: "lzop" } ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 9 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 2 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 5 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 7 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 4 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 Consumers { Name: "user" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565593240541621903 RawX2: 12884914235 }
2025-10-26T18:05:53.494184Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:05:53.494873Z node 4 :PERSQUEUE_READ_BALANCER DEBUG: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037894
2025-10-26T18:05:53.498706Z node 3 :PERSQUEUE DEBUG: Tablet 72075186224037893 server connected, pipe [4:7565593280698283356:7], now have 1 active actors on pipe
2025-10-26T18:05:53.499140Z node 4 :PERSQUEUE_READ_BALANCER DEBUG: tablet 72075186224037894 topic rt3.dc1--topic1 TEvClientConnected TabletId 72075186224037893, NodeId 3, Generation 1
2025-10-26T18:05:53.499739Z node 4 :PERSQUEUE_READ_BALANCER DEBUG: BALANCER INIT DONE for rt3.dc1--topic1: (0, 72075186224037892) (1, 72075186224037892) (2, 72075186224037893) (3, 72075186224037892) (4, 72075186224037893) (5, 72075186224037893) (6, 72075186224037892) (7, 72075186224037893) (8, 72075186224037892) (9, 72075186224037893) 
2025-10-26T18:05:53.499819Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Transactions request. From tx_00000000000000000000, To tx_18446744073709551615
2025-10-26T18:05:53.500047Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] doesn't have tx info
2025-10-26T18:05:53.500075Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] PlanStep 0, PlanTxId 0, ExecStep 0, ExecTxId 0
2025-10-26T18:05:53.500095Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] no config, start with empty partitions and default config
2025-10-26T18:05:53.500112Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Txs.size=0, PlannedTxs.size=0
2025-10-26T18:05:53.500135Z node 4 :PERSQUEUE NOTICE: Tablet 72075186224037892 disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-10-26T18:05:53.500161Z node 4 :PERSQUEUE INFO: Tablet 72075186224037892 doesn't have tx writes info
2025-10-26T18:05:53.500481Z node 4 :PERSQUEUE_READ_BALANCER DEBUG: tablet 72075186224037894 topic rt3.dc1--topic1 TEvClientConnected TabletId 72075186224037892, NodeId 4, Generation 1
2025-10-26T18:05:53.500524Z node 4 :PERSQUEUE DEBUG: Tablet 72075186224037892 server connected, pipe [4:7565593280698283355:7], now have 1 active actors on pipe
2025-10-26T18:05:53.500543Z node 4 :PERSQUEUE DEBUG: Tablet 72075186224037892 server connected, pipe [3:7565593283491296574:8628], now have 1 active actors on pipe
2025-10-26T18:05:53.501136Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPersQueue::TEvProposeTransaction SourceActor { RawX1: 7565593240541621903 RawX2: 12884914235 } TxId: 281474976715677 Config { TabletConfig { PartitionConfig { LifetimeSeconds: 86400 LowWatermark: 8388608 SourceIdLifetimeSeconds: 86400 WriteSpeedInBytesPerSecond: 20000000 BurstSize: 20000000 TotalPartitions: 10 SourceIdMaxCounts: 6000000 } PartitionIds: 3 PartitionIds: 0 PartitionIds: 1 PartitionIds: 6 PartitionIds: 8 TopicName: "rt3.dc1--topic1" Version: 0 LocalDC: true ReadRules: "user" ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } Codecs { Ids: 0 Ids: 1 Ids: 2 Codecs: "raw" Codecs: "gzip" Codecs: "lzop" } ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 3 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 1 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 6 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 8 Status: Active CreateVersion: 1 TabletId: 0 } } }
2025-10-26T18:05:53.501288Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Propose TxId 281474976715677, WriteId (empty maybe)
2025-10-26T18:05:53.501322Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state UNKNOWN
2025-10-26T18:05:53.501340Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State UNKNOWN
2025-10-26T18:05:53.501363Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] schedule TEvProposeTransactionResult(PREPARED)
2025-10-26T18:05:53.501385Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, NewState PREPARING
2025-10-26T18:05:53.501430Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] write key for TxId 281474976715677
2025-10-26T18:05:53.501841Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] save tx TxId: 281474976715677 State: PREPARED MinStep: 1761501953519 MaxStep: 18446744073709551615 Kind: KIND_CONFIG TabletConfig { PartitionConfig { LifetimeSeconds: 86400 LowWatermark: 8388608 SourceIdLifetimeSeconds: 86400 WriteSpeedInBytesPerSecond: 20000000 BurstSize: 20000000 TotalPartitions: 10 SourceIdMaxCounts: 6000000 } PartitionIds: 3 PartitionIds: 0 PartitionIds: 1 PartitionIds: 6 PartitionIds: 8 TopicName: "rt3.dc1--topic1" Version: 0 LocalDC: true ReadRules: "user" ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } Codecs { Ids: 0 Ids: 1 Ids: 2 Codecs: "raw" Codecs: "gzip" Codecs: "lzop" } ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 3 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 1 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 6 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 8 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 Consumers { Name: "user" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565593240541621903 RawX2: 12884914235 }
2025-10-26T18:05:53.501948Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:05:53.502299Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:05:53.502337Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state PREPARING
2025-10-26T18:05:53.502356Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State PREPARING
2025-10-26T18:05:53.502376Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, NewState PREPARED
2025-10-26T18:05:53.502601Z node 4 :PERSQUEUE_READ_BALANCER DEBUG: tablet 72075186224037894 topic rt3.dc1--topic1 TEvClientConnected TabletId 72057594046644480, NodeId 3, Generation 2
2025-10-26T18:05:53.506344Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:05:53.506404Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state PREPARING
2025-10-26T18:05:53.506429Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State PREPARING
2025-10-26T18:05:53.506445Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, NewState PREPARED
2025-10-26T18:05:53.515868Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPersQueue::TEvProposeTransactionAttach TabletId: 72075186224037893 TxId: 281474976715677
2025-10-26T18:05:53.516161Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPersQueue::TEvProposeTransactionAttach TabletId: 72075186224037892 TxId: 281474976715677
2025-10-26T18:05:53.519437Z node 4 :PERSQUEUE DEBUG: Tablet 72075186224037892 server connected, pipe [3:7565593283491296673:8364], now have 1 active actors on pipe
2025-10-26T18:05:53.519118Z node 3 :PERSQUEUE DEBUG: Tablet 72075186224037893 server connected, pipe [3:7565593283491296672:8372], now have 1 active actors on pipe
2025-10-26T18:05:53.519261Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvTxProcessing::TEvPlanStep Transactions { TxId: 281474976715677 AckTo { RawX1: 7565593240541622152 RawX2: 12884910188 } } Step: 1761501953561 MediatorID: 72057594046382081 TabletID: 72075186224037893
2025-10-26T18:05:53.519314Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state PREPARED
2025-10-26T18:05:53.519335Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State PREPARED
2025-10-26T18:05:53.519367Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, NewState PLANNING
2025-10-26T18:05:53.519391Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] PlanStep 1761501953561, PlanTxId 281474976715677
2025-10-26T18:05:53.519428Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] write key for TxId 281474976715677
2025-10-26T18:05:53.520124Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvTxProcessing::TEvPlanStep Transactions { TxId: 281474976715677 AckTo { RawX1: 7565593240541622152 RawX2: 12884910188 } } Step: 1761501953561 MediatorID: 72057594046382081 TabletID: 72075186224037892
2025-10-26T18:05:53.520177Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state PREPARED
2025-10-26T18:05:53.520196Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State PREPARED
2025-10-26T18:05:53.520215Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, NewState PLANNING
2025-10-26T18:05:53.520247Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] PlanStep 1761501953561, PlanTxId 281474976715677
2025-10-26T18:05:53.520275Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] write key for TxId 281474976715677
2025-10-26T18:05:53.520712Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] save tx TxId: 281474976715677 State: PLANNED MinStep: 1761501953519 MaxStep: 18446744073709551615 Step: 1761501953561 Kind: KIND_CONFIG TabletConfig { PartitionConfig { LifetimeSeconds: 86400 LowWatermark: 8388608 SourceIdLifetimeSeconds: 86400 WriteSpeedInBytesPerSecond: 20000000 BurstSize: 20000000 TotalPartitions: 10 SourceIdMaxCounts: 6000000 } PartitionIds: 3 PartitionIds: 0 PartitionIds: 1 PartitionIds: 6 PartitionIds: 8 TopicName: "rt3.dc1--topic1" Version: 0 LocalDC: true ReadRules: "user" ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } Codecs { Ids: 0 Ids: 1 Ids: 2 Codecs: "raw" Codecs: "gzip" Codecs: "lzop" } ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 3 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 1 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 6 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 8 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 Consumers { Name: "user" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565593240541621903 RawX2: 12884914235 }
2025-10-26T18:05:53.520471Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] save tx TxId: 281474976715677 State: PLANNED MinStep: 1761501953519 MaxStep: 18446744073709551615 Step: 1761501953561 Kind: KIND_CONFIG TabletConfig { PartitionConfig { LifetimeSeconds: 86400 LowWatermark: 8388608 SourceIdLifetimeSeconds: 86400 WriteSpeedInBytesPerSecond: 20000000 BurstSize: 20000000 TotalPartitions: 10 SourceIdMaxCounts: 6000000 } PartitionIds: 9 PartitionIds: 2 PartitionIds: 5 PartitionIds: 7 PartitionIds: 4 TopicName: "rt3.dc1--topic1" Version: 0 LocalDC: true ReadRules: "user" ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } Codecs { Ids: 0 Ids: 1 Ids: 2 Codecs: "raw" Codecs: "gzip" Codecs: "lzop" } ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 9 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 2 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 5 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 7 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 4 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 Consumers { Name: "user" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565593240541621903 RawX2: 12884914235 }
2025-10-26T18:05:53.520804Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:05:53.520608Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:05:53.523634Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:05:53.523688Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state PLANNING
2025-10-26T18:05:53.523727Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State PLANNING
2025-10-26T18:05:53.523760Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, NewState PLANNED
2025-10-26T18:05:53.523785Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 moved from PLANNING to PLANNED
2025-10-26T18:05:53.523797Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxQueue.size 1
2025-10-26T18:05:53.523814Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] New ExecStep 1761501953561, ExecTxId 281474976715677
2025-10-26T18:05:53.526430Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, NewState CALCULATING
2025-10-26T18:05:53.526463Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 moved from PLANNED to CALCULATING
2025-10-26T18:05:53.526528Z node 3 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 9. Step TInitConfigStep
2025-10-26T18:05:53.527771Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:05:53.527841Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state PLANNING
2025-10-26T18:05:53.527861Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State PLANNING
2025-10-26T18:05:53.527884Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, NewState PLANNED
2025-10-26T18:05:53.527903Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 moved from PLANNING to PLANNED
2025-10-26T18:05:53.527917Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxQueue.size 1
2025-10-26T18:05:53.527935Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] New ExecStep 1761501953561, ExecTxId 281474976715677
2025-10-26T18:05:53.530267Z node 4 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 0. Step TInitConfigStep
2025-10-26T18:05:53.530358Z node 4 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 1. Step TInitConfigStep
2025-10-26T18:05:53.530408Z node 4 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 3. Step TInitConfigStep
2025-10-26T18:05:53.531667Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, NewState CALCULATING
2025-10-26T18:05:53.531704Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 moved from PLANNED to CALCULATING
2025-10-26T18:05:53.532142Z node 4 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 6. Step TInitConfigStep
2025-10-26T18:05:53.532196Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 6, State: StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-26T18:05:53.532215Z node 4 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 8. Step TInitConfigStep
2025-10-26T18:05:53.532238Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 8, State: StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-26T18:05:53.532325Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 0, State: StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-26T18:05:53.532429Z node 4 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 0. Step TInitInternalFieldsStep
2025-10-26T18:05:53.532668Z node 4 :PERSQUEUE INFO: bootstrapping 0 [4:7565593280698283374:4324]
2025-10-26T18:05:53.526896Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 9, State: StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-26T18:05:53.527225Z node 3 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 9. Step TInitInternalFieldsStep
2025-10-26T18:05:53.527391Z node 3 :PERSQUEUE INFO: bootstrapping 9 [3:7565593283491296684:4308]
2025-10-26T18:05:53.530656Z node 3 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 9. Completed.
2025-10-26T18:05:53.530675Z node 3 :PERSQUEUE INFO: init complete for topic 'rt3.dc1--topic1' partition 9 generation 1 [3:7565593283491296684:4308]
2025-10-26T18:05:53.533849Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 1, State: StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-26T18:05:53.533937Z node 4 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 1. Step TInitInternalFieldsStep
2025-10-26T18:05:53.534173Z node 4 :PERSQUEUE INFO: bootstrapping 1 [4:7565593280698283375:4325]
2025-10-26T18:05:53.530704Z node 3 :PERSQUEUE DEBUG: SYNC INIT topic rt3.dc1--topic1 partitition 9 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-10-26T18:05:53.532291Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 9, State: StateIdle] Process pending events. Count 1
2025-10-26T18:05:53.532435Z node 3 :PERSQUEUE DEBUG: Topic 'rt3.dc1--topic1' partition 9 user user readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:05:53.532716Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPQ::TEvProposePartitionConfigResult Step 1761501953561, TxId 281474976715677, Partition 9
2025-10-26T18:05:53.532734Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] Handle TEvProposePartitionConfigResult
2025-10-26T18:05:53.532747Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] Partition responses 1/5
2025-10-26T18:05:53.532765Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state CALCULATING
2025-10-26T18:05:53.532782Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State CALCULATING
2025-10-26T18:05:53.532801Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 State CALCULATING FrontTxId 281474976715677
2025-10-26T18:05:53.532815Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 1, Expected 5
2025-10-26T18:05:53.532837Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.533010Z node 3 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 2. Step TInitConfigStep
2025-10-26T18:05:53.533060Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 2, State: StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-26T18:05:53.533403Z node 3 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 2. Step TInitInternalFieldsStep
2025-10-26T18:05:53.533643Z node 3 :PERSQUEUE INFO: bootstrapping 2 [3:7565593283491296685:4338]
2025-10-26T18:05:53.536098Z node 3 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 2. Completed.
2025-10-26T18:05:53.536117Z node 3 :PERSQUEUE INFO: init complete for topic 'rt3.dc1--topic1' partition 2 generation 1 [3:7565593283491296685:4338]
2025-10-26T18:05:53.536140Z node 3 :PERSQUEUE DEBUG: SYNC INIT topic rt3.dc1--topic1 partitition 2 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-10-26T18:05:53.537285Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 2, State: StateIdle] Process pending events. Count 1
2025-10-26T18:05:53.537447Z node 3 :PERSQUEUE DEBUG: Topic 'rt3.dc1--topic1' partition 2 user user readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:05:53.537740Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPQ::TEvProposePartitionConfigResult Step 1761501953561, TxId 281474976715677, Partition 2
2025-10-26T18:05:53.537759Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] Handle TEvProposePartitionConfigResult
2025-10-26T18:05:53.537774Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] Partition responses 2/5
2025-10-26T18:05:53.537795Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state CALCULATING
2025-10-26T18:05:53.537812Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State CALCULATING
2025-10-26T18:05:53.537831Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 State CALCULATING FrontTxId 281474976715677
2025-10-26T18:05:53.537845Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 2, Expected 5
2025-10-26T18:05:53.537860Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.538120Z node 3 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 5. Step TInitConfigStep
2025-10-26T18:05:53.538168Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 5, State: StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-26T18:05:53.538423Z node 3 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 7. Step TInitConfigStep
2025-10-26T18:05:53.538449Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 7, State: StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-26T18:05:53.538516Z node 3 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 5. Step TInitInternalFieldsStep
2025-10-26T18:05:53.538770Z node 3 :PERSQUEUE INFO: bootstrapping 5 [3:7565593283491296686:4317]
2025-10-26T18:05:53.541132Z node 3 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 5. Completed.
2025-10-26T18:05:53.541157Z node 3 :PERSQUEUE INFO: init complete for topic 'rt3.dc1--topic1' partition 5 generation 1 [3:7565593283491296686:4317]
2025-10-26T18:05:53.541194Z node 3 :PERSQUEUE DEBUG: SYNC INIT topic rt3.dc1--topic1 partitition 5 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-10-26T18:05:53.537304Z node 4 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 1. Completed.
2025-10-26T18:05:53.537345Z node 4 :PERSQUEUE INFO: init complete for topic 'rt3.dc1--topic1' partition 1 generation 1 [4:7565593280698283375:4325]
2025-10-26T18:05:53.537371Z node 4 :PERSQUEUE DEBUG: SYNC INIT topic rt3.dc1--topic1 partitition 1 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-10-26T18:05:53.538563Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 1, State: StateIdle] Process pending events. Count 1
2025-10-26T18:05:53.538737Z node 4 :PERSQUEUE DEBUG: Topic 'rt3.dc1--topic1' partition 1 user user readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:05:53.539090Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 3, State: StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-26T18:05:53.539168Z node 4 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 3. Step TInitInternalFieldsStep
2025-10-26T18:05:53.539312Z node 4 :PERSQUEUE INFO: bootstrapping 3 [4:7565593280698283373:4323]
2025-10-26T18:05:53.540825Z node 4 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 3. Completed.
2025-10-26T18:05:53.540839Z node 4 :PERSQUEUE INFO: init complete for topic 'rt3.dc1--topic1' partition 3 generation 1 [4:7565593280698283373:4323]
2025-10-26T18:05:53.540857Z node 4 :PERSQUEUE DEBUG: SYNC INIT topic rt3.dc1--topic1 partitition 3 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-10-26T18:05:53.542632Z node 4 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 0. Completed.
2025-10-26T18:05:53.542664Z node 4 :PERSQUEUE INFO: init complete for topic 'rt3.dc1--topic1' partition 0 generation 1 [4:7565593280698283374:4324]
2025-10-26T18:05:53.542688Z node 4 :PERSQUEUE DEBUG: SYNC INIT topic rt3.dc1--topic1 partitition 0 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-10-26T18:05:53.543467Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Process pending events. Count 1
2025-10-26T18:05:53.543598Z node 4 :PERSQUEUE DEBUG: Topic 'rt3.dc1--topic1' partition 0 user user readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:05:53.543779Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPQ::TEvProposePartitionConfigResult Step 1761501953561, TxId 281474976715677, Partition 1
2025-10-26T18:05:53.543801Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] Handle TEvProposePartitionConfigResult
2025-10-26T18:05:53.543816Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] Partition responses 1/5
2025-10-26T18:05:53.543837Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state CALCULATING
2025-10-26T18:05:53.543860Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State CALCULATING
2025-10-26T18:05:53.543883Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 State CALCULATING FrontTxId 281474976715677
2025-10-26T18:05:53.543899Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 1, Expected 5
2025-10-26T18:05:53.543919Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.544110Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPQ::TEvProposePartitionConfigResult Step 1761501953561, TxId 281474976715677, Partition 0
2025-10-26T18:05:53.544128Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] Handle TEvProposePartitionConfigResult
2025-10-26T18:05:53.544138Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] Partition responses 2/5
2025-10-26T18:05:53.544149Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state CALCULATING
2025-10-26T18:05:53.544173Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State CALCULATING
2025-10-26T18:05:53.544188Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 State CALCULATING FrontTxId 281474976715677
2025-10-26T18:05:53.544198Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 2, Expected 5
2025-10-26T18:05:53.544209Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.544535Z node 4 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 6. Step TInitInternalFieldsStep
2025-10-26T18:05:53.544733Z node 4 :PERSQUEUE INFO: bootstrapping 6 [4:7565593280698283376:4326]
2025-10-26T18:05:53.542369Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 5, State: StateIdle] Process pending events. Count 1
2025-10-26T18:05:53.542510Z node 3 :PERSQUEUE DEBUG: Topic 'rt3.dc1--topic1' partition 5 user user readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:05:53.542692Z node 3 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 4. Step TInitConfigStep
2025-10-26T18:05:53.542743Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 4, State: StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-26T18:05:53.543157Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPQ::TEvProposePartitionConfigResult Step 1761501953561, TxId 281474976715677, Partition 5
2025-10-26T18:05:53.543174Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] Handle TEvProposePartitionConfigResult
2025-10-26T18:05:53.543188Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] Partition responses 3/5
2025-10-26T18:05:53.543205Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state CALCULATING
2025-10-26T18:05:53.543221Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State CALCULATING
2025-10-26T18:05:53.543241Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 State CALCULATING FrontTxId 281474976715677
2025-10-26T18:05:53.543254Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 3, Expected 5
2025-10-26T18:05:53.543269Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.543739Z node 3 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 7. Step TInitInternalFieldsStep
2025-10-26T18:05:53.543996Z node 3 :PERSQUEUE INFO: bootstrapping 7 [3:7565593283491296687:4318]
2025-10-26T18:05:53.546708Z node 3 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 7. Completed.
2025-10-26T18:05:53.546730Z node 3 :PERSQUEUE INFO: init complete for topic 'rt3.dc1--topic1' partition 7 generation 1 [3:7565593283491296687:4318]
2025-10-26T18:05:53.546757Z node 3 :PERSQUEUE DEBUG: SYNC INIT topic rt3.dc1--topic1 partitition 7 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-10-26T18:05:53.547937Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 7, State: StateIdle] Process pending events. Count 1
2025-10-26T18:05:53.548057Z node 3 :PERSQUEUE DEBUG: Topic 'rt3.dc1--topic1' partition 7 user user readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:05:53.548321Z node 3 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 4. Step TInitInternalFieldsStep
2025-10-26T18:05:53.548567Z node 3 :PERSQUEUE INFO: bootstrapping 4 [3:7565593283491296688:4319]
2025-10-26T18:05:53.545827Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 3, State: StateIdle] Process pending events. Count 1
2025-10-26T18:05:53.545950Z node 4 :PERSQUEUE DEBUG: Topic 'rt3.dc1--topic1' partition 3 user user readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:05:53.546192Z node 4 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 8. Step TInitInternalFieldsStep
2025-10-26T18:05:53.546355Z node 4 :PERSQUEUE INFO: bootstrapping 8 [4:7565593280698283377:4287]
2025-10-26T18:05:53.546666Z node 4 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 6. Completed.
2025-10-26T18:05:53.546680Z node 4 :PERSQUEUE INFO: init complete for topic 'rt3.dc1--topic1' partition 6 generation 1 [4:7565593280698283376:4326]
2025-10-26T18:05:53.546699Z node 4 :PERSQUEUE DEBUG: SYNC INIT topic rt3.dc1--topic1 partitition 6 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-10-26T18:05:53.547853Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 6, State: StateIdle] Process pending events. Count 1
2025-10-26T18:05:53.547956Z node 4 :PERSQUEUE DEBUG: Topic 'rt3.dc1--topic1' partition 6 user user readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:05:53.548394Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPQ::TEvProposePartitionConfigResult Step 1761501953561, TxId 281474976715677, Partition 3
2025-10-26T18:05:53.548414Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] Handle TEvProposePartitionConfigResult
2025-10-26T18:05:53.548431Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] Partition responses 3/5
2025-10-26T18:05:53.548448Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state CALCULATING
2025-10-26T18:05:53.548467Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State CALCULATING
2025-10-26T18:05:53.548488Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 State CALCULATING FrontTxId 281474976715677
2025-10-26T18:05:53.548504Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 3, Expected 5
2025-10-26T18:05:53.548525Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.548694Z node 4 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 8. Completed.
2025-10-26T18:05:53.548707Z node 4 :PERSQUEUE INFO: init complete for topic 'rt3.dc1--topic1' partition 8 generation 1 [4:7565593280698283377:4287]
2025-10-26T18:05:53.548717Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPQ::TEvProposePartitionConfigResult Step 1761501953561, TxId 281474976715677, Partition 6
2025-10-26T18:05:53.548728Z node 4 :PERSQUEUE DEBUG: SYNC INIT topic rt3.dc1--topic1 partitition 8 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-10-26T18:05:53.548729Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] Handle TEvProposePartitionConfigResult
2025-10-26T18:05:53.548739Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] Partition responses 4/5
2025-10-26T18:05:53.548749Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state CALCULATING
2025-10-26T18:05:53.548761Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State CALCULATING
2025-10-26T18:05:53.548773Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 State CALCULATING FrontTxId 281474976715677
2025-10-26T18:05:53.548782Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 4, Expected 5
2025-10-26T18:05:53.548792Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.550883Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 8, State: StateIdle] Process pending events. Count 1
2025-10-26T18:05:53.551022Z node 4 :PERSQUEUE DEBUG: Topic 'rt3.dc1--topic1' partition 8 user user readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:05:53.551199Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPQ::TEvProposePartitionConfigResult Step 1761501953561, TxId 281474976715677, Partition 8
2025-10-26T18:05:53.551218Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] Handle TEvProposePartitionConfigResult
2025-10-26T18:05:53.551230Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] Partition responses 5/5
2025-10-26T18:05:53.551243Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state CALCULATING
2025-10-26T18:05:53.551254Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State CALCULATING
2025-10-26T18:05:53.551265Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 State CALCULATING FrontTxId 281474976715677
2025-10-26T18:05:53.551274Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 5, Expected 5
2025-10-26T18:05:53.551286Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, NewState CALCULATED
2025-10-26T18:05:53.551301Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 moved from CALCULATING to CALCULATED
2025-10-26T18:05:53.551288Z node 3 :PERSQUEUE DEBUG: Initializing topic 'rt3.dc1--topic1' partition 4. Completed.
2025-10-26T18:05:53.551319Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] write key for TxId 281474976715677
2025-10-26T18:05:53.551320Z node 3 :PERSQUEUE INFO: init complete for topic 'rt3.dc1--topic1' partition 4 generation 1 [3:7565593283491296688:4319]
2025-10-26T18:05:53.551342Z node 3 :PERSQUEUE DEBUG: SYNC INIT topic rt3.dc1--topic1 partitition 4 so 0 endOffset 0 Head Offset 0 PartNo 0 PackedSize 0 count 0 nextOffset 0 batches 0
2025-10-26T18:05:53.551708Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] save tx TxId: 281474976715677 State: CALCULATED MinStep: 1761501953519 MaxStep: 18446744073709551615 Step: 1761501953561 Predicate: true Kind: KIND_CONFIG TabletConfig { PartitionConfig { LifetimeSeconds: 86400 LowWatermark: 8388608 SourceIdLifetimeSeconds: 86400 WriteSpeedInBytesPerSecond: 20000000 BurstSize: 20000000 TotalPartitions: 10 SourceIdMaxCounts: 6000000 } PartitionIds: 3 PartitionIds: 0 PartitionIds: 1 PartitionIds: 6 PartitionIds: 8 TopicName: "rt3.dc1--topic1" Version: 0 LocalDC: true ReadRules: "user" ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } Codecs { Ids: 0 Ids: 1 Ids: 2 Codecs: "raw" Codecs: "gzip" Codecs: "lzop" } ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 3 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 1 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 6 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 8 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 Consumers { Name: "user" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565593240541621903 RawX2: 12884914235 }
2025-10-26T18:05:53.551797Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:05:53.552424Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 4, State: StateIdle] Process pending events. Count 1
2025-10-26T18:05:53.552554Z node 3 :PERSQUEUE DEBUG: Topic 'rt3.dc1--topic1' partition 4 user user readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:05:53.552830Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPQ::TEvProposePartitionConfigResult Step 1761501953561, TxId 281474976715677, Partition 7
2025-10-26T18:05:53.552858Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] Handle TEvProposePartitionConfigResult
2025-10-26T18:05:53.552870Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] Partition responses 4/5
2025-10-26T18:05:53.552888Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state CALCULATING
2025-10-26T18:05:53.552905Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State CALCULATING
2025-10-26T18:05:53.552923Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 State CALCULATING FrontTxId 281474976715677
2025-10-26T18:05:53.552936Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 4, Expected 5
2025-10-26T18:05:53.552950Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.553134Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPQ::TEvProposePartitionConfigResult Step 1761501953561, TxId 281474976715677, Partition 4
2025-10-26T18:05:53.553145Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] Handle TEvProposePartitionConfigResult
2025-10-26T18:05:53.553156Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] Partition responses 5/5
2025-10-26T18:05:53.553178Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state CALCULATING
2025-10-26T18:05:53.553190Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State CALCULATING
2025-10-26T18:05:53.553203Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 State CALCULATING FrontTxId 281474976715677
2025-10-26T18:05:53.553213Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 5, Expected 5
2025-10-26T18:05:53.553240Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, NewState CALCULATED
2025-10-26T18:05:53.553264Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 moved from CALCULATING to CALCULATED
2025-10-26T18:05:53.553284Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] write key for TxId 281474976715677
2025-10-26T18:05:53.553907Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] save tx TxId: 281474976715677 State: CALCULATED MinStep: 1761501953519 MaxStep: 18446744073709551615 Step: 1761501953561 Predicate: true Kind: KIND_CONFIG TabletConfig { PartitionConfig { LifetimeSeconds: 86400 LowWatermark: 8388608 SourceIdLifetimeSeconds: 86400 WriteSpeedInBytesPerSecond: 20000000 BurstSize: 20000000 TotalPartitions: 10 SourceIdMaxCounts: 6000000 } PartitionIds: 9 PartitionIds: 2 PartitionIds: 5 PartitionIds: 7 PartitionIds: 4 TopicName: "rt3.dc1--topic1" Version: 0 LocalDC: true ReadRules: "user" ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } Codecs { Ids: 0 Ids: 1 Ids: 2 Codecs: "raw" Codecs: "gzip" Codecs: "lzop" } ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 9 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 2 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 5 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 7 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 4 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 Consumers { Name: "user" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565593240541621903 RawX2: 12884914235 }
2025-10-26T18:05:53.554033Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:05:53.558017Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:05:53.558056Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state CALCULATED
2025-10-26T18:05:53.558073Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State CALCULATED
2025-10-26T18:05:53.558090Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 State CALCULATED FrontTxId 281474976715677
2025-10-26T18:05:53.558106Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, NewState WAIT_RS
2025-10-26T18:05:53.558127Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 moved from CALCULATED to WAIT_RS
2025-10-26T18:05:53.558147Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Send TEvTxProcessing::TEvReadSet to 0 receivers. Wait TEvTxProcessing::TEvReadSet from 0 senders.
2025-10-26T18:05:53.558162Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] HaveParticipantsDecision 1
2025-10-26T18:05:53.558219Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, NewState EXECUTING
2025-10-26T18:05:53.558248Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 moved from WAIT_RS to EXECUTING
2025-10-26T18:05:53.558259Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 0, Expected 5
2025-10-26T18:05:53.558336Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 0, State: StateIdle] Handle TEvPQ::TEvTxCommit Step 1761501953561, TxId 281474976715677
2025-10-26T18:05:53.558646Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 8, State: StateIdle] Handle TEvPQ::TEvTxCommit Step 1761501953561, TxId 281474976715677
2025-10-26T18:05:53.558853Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 1, State: StateIdle] Handle TEvPQ::TEvTxCommit Step 1761501953561, TxId 281474976715677
2025-10-26T18:05:53.559033Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 3, State: StateIdle] Handle TEvPQ::TEvTxCommit Step 1761501953561, TxId 281474976715677
2025-10-26T18:05:53.559223Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 6, State: StateIdle] Handle TEvPQ::TEvTxCommit Step 1761501953561, TxId 281474976715677
2025-10-26T18:05:53.559381Z node 4 :PERSQUEUE DEBUG: CacheProxy. Passthrough write request to KV
2025-10-26T18:05:53.559461Z node 4 :PERSQUEUE DEBUG: CacheProxy. Passthrough write request to KV
2025-10-26T18:05:53.559496Z node 4 :PERSQUEUE DEBUG: CacheProxy. Passthrough write request to KV
2025-10-26T18:05:53.559524Z node 4 :PERSQUEUE DEBUG: CacheProxy. Passthrough write request to KV
2025-10-26T18:05:53.559554Z node 4 :PERSQUEUE DEBUG: CacheProxy. Passthrough write request to KV
2025-10-26T18:05:53.562680Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:05:53.562718Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state CALCULATED
2025-10-26T18:05:53.562737Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State CALCULATED
2025-10-26T18:05:53.562754Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 State CALCULATED FrontTxId 281474976715677
2025-10-26T18:05:53.562769Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, NewState WAIT_RS
2025-10-26T18:05:53.562789Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 moved from CALCULATED to WAIT_RS
2025-10-26T18:05:53.562808Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Send TEvTxProcessing::TEvReadSet to 0 receivers. Wait TEvTxProcessing::TEvReadSet from 0 senders.
2025-10-26T18:05:53.562823Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] HaveParticipantsDecision 1
2025-10-26T18:05:53.562865Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, NewState EXECUTING
2025-10-26T18:05:53.562883Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 moved from WAIT_RS to EXECUTING
2025-10-26T18:05:53.562894Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 0, Expected 5
2025-10-26T18:05:53.564915Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 7, State: StateIdle] Handle TEvPQ::TEvTxCommit Step 1761501953561, TxId 281474976715677
2025-10-26T18:05:53.565308Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 2, State: StateIdle] Handle TEvPQ::TEvTxCommit Step 1761501953561, TxId 281474976715677
2025-10-26T18:05:53.565539Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 9, State: StateIdle] Handle TEvPQ::TEvTxCommit Step 1761501953561, TxId 281474976715677
2025-10-26T18:05:53.565663Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 4, State: StateIdle] Handle TEvPQ::TEvTxCommit Step 1761501953561, TxId 281474976715677
2025-10-26T18:05:53.565831Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 5, State: StateIdle] Handle TEvPQ::TEvTxCommit Step 1761501953561, TxId 281474976715677
2025-10-26T18:05:53.566024Z node 3 :PERSQUEUE DEBUG: CacheProxy. Passthrough write request to KV
2025-10-26T18:05:53.566098Z node 3 :PERSQUEUE DEBUG: CacheProxy. Passthrough write request to KV
2025-10-26T18:05:53.566149Z node 3 :PERSQUEUE DEBUG: CacheProxy. Passthrough write request to KV
2025-10-26T18:05:53.566199Z node 3 :PERSQUEUE DEBUG: CacheProxy. Passthrough write request to KV
2025-10-26T18:05:53.566253Z node 3 :PERSQUEUE DEBUG: CacheProxy. Passthrough write request to KV
2025-10-26T18:05:53.567770Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 0, State: StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-26T18:05:53.567951Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 1, State: StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-26T18:05:53.567989Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 8, State: StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-26T18:05:53.568038Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPQ::TEvTxCommitDone Step 1761501953561, TxId 281474976715677, Partition 0
2025-10-26T18:05:53.568056Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state EXECUTING
2025-10-26T18:05:53.568071Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State EXECUTING
2025-10-26T18:05:53.568088Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 State EXECUTING FrontTxId 281474976715677
2025-10-26T18:05:53.568099Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 1, Expected 5
2025-10-26T18:05:53.568120Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.568157Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPQ::TEvTxCommitDone Step 1761501953561, TxId 281474976715677, Partition 8
2025-10-26T18:05:53.568170Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state EXECUTING
2025-10-26T18:05:53.568179Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State EXECUTING
2025-10-26T18:05:53.568190Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 State EXECUTING FrontTxId 281474976715677
2025-10-26T18:05:53.568200Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 2, Expected 5
2025-10-26T18:05:53.568210Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.568233Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPQ::TEvTxCommitDone Step 1761501953561, TxId 281474976715677, Partition 1
2025-10-26T18:05:53.568245Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state EXECUTING
2025-10-26T18:05:53.568256Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State EXECUTING
2025-10-26T18:05:53.568266Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 State EXECUTING FrontTxId 281474976715677
2025-10-26T18:05:53.568274Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 3, Expected 5
2025-10-26T18:05:53.568284Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.571245Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 7, State: StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-26T18:05:53.571730Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 3, State: StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-26T18:05:53.571833Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPQ::TEvTxCommitDone Step 1761501953561, TxId 281474976715677, Partition 3
2025-10-26T18:05:53.571851Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state EXECUTING
2025-10-26T18:05:53.571862Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 6, State: StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-26T18:05:53.571866Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State EXECUTING
2025-10-26T18:05:53.571881Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 State EXECUTING FrontTxId 281474976715677
2025-10-26T18:05:53.571891Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 4, Expected 5
2025-10-26T18:05:53.571904Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.571934Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPQ::TEvTxCommitDone Step 1761501953561, TxId 281474976715677, Partition 6
2025-10-26T18:05:53.571944Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state EXECUTING
2025-10-26T18:05:53.571467Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 2, State: StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-26T18:05:53.571667Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 9, State: StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-26T18:05:53.571953Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State EXECUTING
2025-10-26T18:05:53.571811Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 4, State: StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-26T18:05:53.571964Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 State EXECUTING FrontTxId 281474976715677
2025-10-26T18:05:53.571952Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 5, State: StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-26T18:05:53.571972Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 5, Expected 5
2025-10-26T18:05:53.572762Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPQ::TEvTxCommitDone Step 1761501953561, TxId 281474976715677, Partition 7
2025-10-26T18:05:53.571993Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId: 281474976715677 send TEvPersQueue::TEvProposeTransactionResult(COMPLETE)
2025-10-26T18:05:53.572778Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state EXECUTING
2025-10-26T18:05:53.572016Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] complete TxId 281474976715677
2025-10-26T18:05:53.572419Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Apply new config PartitionConfig { LifetimeSeconds: 86400 LowWatermark: 8388608 SourceIdLifetimeSeconds: 86400 WriteSpeedInBytesPerSecond: 20000000 BurstSize: 20000000 TotalPartitions: 10 SourceIdMaxCounts: 6000000 } PartitionIds: 3 PartitionIds: 0 PartitionIds: 1 PartitionIds: 6 PartitionIds: 8 TopicName: "rt3.dc1--topic1" Version: 0 LocalDC: true ReadRules: "user" ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } Codecs { Ids: 0 Ids: 1 Ids: 2 Codecs: "raw" Codecs: "gzip" Codecs: "lzop" } ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 3 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 1 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 6 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 8 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 Consumers { Name: "user" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } Version: 0 Generation: 0 Important: false }
2025-10-26T18:05:53.572791Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State EXECUTING
2025-10-26T18:05:53.572516Z node 4 :PERSQUEUE NOTICE: Tablet 72075186224037892 disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-10-26T18:05:53.572805Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 State EXECUTING FrontTxId 281474976715677
2025-10-26T18:05:53.572576Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] delete partitions for TxId 281474976715677
2025-10-26T18:05:53.572818Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 1, Expected 5
2025-10-26T18:05:53.572594Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, NewState EXECUTED
2025-10-26T18:05:53.572828Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.572614Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 moved from EXECUTING to EXECUTED
2025-10-26T18:05:53.572864Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPQ::TEvTxCommitDone Step 1761501953561, TxId 281474976715677, Partition 2
2025-10-26T18:05:53.572633Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] write key for TxId 281474976715677
2025-10-26T18:05:53.572876Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state EXECUTING
2025-10-26T18:05:53.573033Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] save tx TxId: 281474976715677 State: EXECUTED MinStep: 1761501953519 MaxStep: 18446744073709551615 Step: 1761501953561 Predicate: true Kind: KIND_CONFIG TabletConfig { PartitionConfig { LifetimeSeconds: 86400 LowWatermark: 8388608 SourceIdLifetimeSeconds: 86400 WriteSpeedInBytesPerSecond: 20000000 BurstSize: 20000000 TotalPartitions: 10 SourceIdMaxCounts: 6000000 } PartitionIds: 3 PartitionIds: 0 PartitionIds: 1 PartitionIds: 6 PartitionIds: 8 TopicName: "rt3.dc1--topic1" Version: 0 LocalDC: true ReadRules: "user" ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } Codecs { Ids: 0 Ids: 1 Ids: 2 Codecs: "raw" Codecs: "gzip" Codecs: "lzop" } ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 3 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 1 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 6 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 8 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 Consumers { Name: "user" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565593240541621903 RawX2: 12884914235 }
2025-10-26T18:05:53.573233Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:05:53.572885Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State EXECUTING
2025-10-26T18:05:53.572896Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 State EXECUTING FrontTxId 281474976715677
2025-10-26T18:05:53.572913Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 2, Expected 5
2025-10-26T18:05:53.572931Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.572957Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPQ::TEvTxCommitDone Step 1761501953561, TxId 281474976715677, Partition 9
2025-10-26T18:05:53.572966Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state EXECUTING
2025-10-26T18:05:53.572975Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State EXECUTING
2025-10-26T18:05:53.572987Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 State EXECUTING FrontTxId 281474976715677
2025-10-26T18:05:53.572996Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 3, Expected 5
2025-10-26T18:05:53.573005Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.573035Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPQ::TEvTxCommitDone Step 1761501953561, TxId 281474976715677, Partition 4
2025-10-26T18:05:53.573046Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state EXECUTING
2025-10-26T18:05:53.573066Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State EXECUTING
2025-10-26T18:05:53.573077Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 State EXECUTING FrontTxId 281474976715677
2025-10-26T18:05:53.573086Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 4, Expected 5
2025-10-26T18:05:53.573096Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 status has not changed
2025-10-26T18:05:53.573127Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPQ::TEvTxCommitDone Step 1761501953561, TxId 281474976715677, Partition 5
2025-10-26T18:05:53.573139Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state EXECUTING
2025-10-26T18:05:53.573149Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State EXECUTING
2025-10-26T18:05:53.573159Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 State EXECUTING FrontTxId 281474976715677
2025-10-26T18:05:53.573181Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 5, Expected 5
2025-10-26T18:05:53.573197Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId: 281474976715677 send TEvPersQueue::TEvProposeTransactionResult(COMPLETE)
2025-10-26T18:05:53.573219Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] complete TxId 281474976715677
2025-10-26T18:05:53.573554Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Apply new config PartitionConfig { LifetimeSeconds: 86400 LowWatermark: 8388608 SourceIdLifetimeSeconds: 86400 WriteSpeedInBytesPerSecond: 20000000 BurstSize: 20000000 TotalPartitions: 10 SourceIdMaxCounts: 6000000 } PartitionIds: 9 PartitionIds: 2 PartitionIds: 5 PartitionIds: 7 PartitionIds: 4 TopicName: "rt3.dc1--topic1" Version: 0 LocalDC: true ReadRules: "user" ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } Codecs { Ids: 0 Ids: 1 Ids: 2 Codecs: "raw" Codecs: "gzip" Codecs: "lzop" } ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 9 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 2 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 5 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 7 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 4 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 Consumers { Name: "user" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } Version: 0 Generation: 0 Important: false }
2025-10-26T18:05:53.573613Z node 3 :PERSQUEUE NOTICE: Tablet 72075186224037893 disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-10-26T18:05:53.573659Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] delete partitions for TxId 281474976715677
2025-10-26T18:05:53.573675Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, NewState EXECUTED
2025-10-26T18:05:53.574928Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 moved from EXECUTING to EXECUTED
2025-10-26T18:05:53.574948Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] write key for TxId 281474976715677
2025-10-26T18:05:53.575215Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] save tx TxId: 281474976715677 State: EXECUTED MinStep: 1761501953519 MaxStep: 18446744073709551615 Step: 1761501953561 Predicate: true Kind: KIND_CONFIG TabletConfig { PartitionConfig { LifetimeSeconds: 86400 LowWatermark: 8388608 SourceIdLifetimeSeconds: 86400 WriteSpeedInBytesPerSecond: 20000000 BurstSize: 20000000 TotalPartitions: 10 SourceIdMaxCounts: 6000000 } PartitionIds: 9 PartitionIds: 2 PartitionIds: 5 PartitionIds: 7 PartitionIds: 4 TopicName: "rt3.dc1--topic1" Version: 0 LocalDC: true ReadRules: "user" ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } Codecs { Ids: 0 Ids: 1 Ids: 2 Codecs: "raw" Codecs: "gzip" Codecs: "lzop" } ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 9 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 2 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 5 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 7 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 4 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 Consumers { Name: "user" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565593240541621903 RawX2: 12884914235 }
2025-10-26T18:05:53.575322Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:05:53.580142Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:05:53.580175Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state EXECUTED
2025-10-26T18:05:53.580187Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State EXECUTED
2025-10-26T18:05:53.580201Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 State EXECUTED FrontTxId 281474976715677
2025-10-26T18:05:53.580212Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TPersQueue::SendEvReadSetAckToSenders
2025-10-26T18:05:53.580224Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, NewState WAIT_RS_ACKS
2025-10-26T18:05:53.580234Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677 moved from EXECUTED to WAIT_RS_ACKS
2025-10-26T18:05:53.580248Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] PredicateAcks: 0/0
2025-10-26T18:05:53.580254Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] HaveAllRecipientsReceive 1, AllSupportivePartitionsHaveBeenDeleted 1
2025-10-26T18:05:53.580263Z node 3 :PERSQUEUE DEBUG: [TxId: 281474976715677] PredicateAcks: 0/0
2025-10-26T18:05:53.580272Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] add an TxId 281474976715677 to the list for deletion
2025-10-26T18:05:53.580284Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, NewState DELETING
2025-10-26T18:05:53.580298Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] delete key for TxId 281474976715677
2025-10-26T18:05:53.580334Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:05:53.580288Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:05:53.580319Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state EXECUTED
2025-10-26T18:05:53.580333Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State EXECUTED
2025-10-26T18:05:53.580352Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 State EXECUTED FrontTxId 281474976715677
2025-10-26T18:05:53.580365Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TPersQueue::SendEvReadSetAckToSenders
2025-10-26T18:05:53.580380Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, NewState WAIT_RS_ACKS
2025-10-26T18:05:53.580396Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677 moved from EXECUTED to WAIT_RS_ACKS
2025-10-26T18:05:53.580413Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] PredicateAcks: 0/0
2025-10-26T18:05:53.580421Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] HaveAllRecipientsReceive 1, AllSupportivePartitionsHaveBeenDeleted 1
2025-10-26T18:05:53.580431Z node 4 :PERSQUEUE DEBUG: [TxId: 281474976715677] PredicateAcks: 0/0
2025-10-26T18:05:53.580445Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] add an TxId 281474976715677 to the list for deletion
2025-10-26T18:05:53.580461Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, NewState DELETING
2025-10-26T18:05:53.580478Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] delete key for TxId 281474976715677
2025-10-26T18:05:53.580520Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:05:53.581951Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:05:53.581983Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state DELETING
2025-10-26T18:05:53.581996Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715677, State DELETING
2025-10-26T18:05:53.582012Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893] delete TxId 281474976715677
2025-10-26T18:05:53.582743Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:05:53.582770Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state DELETING
2025-10-26T18:05:53.582794Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715677, State DELETING
2025-10-26T18:05:53.582810Z node 4 :PERSQUEUE DEBUG: [PQ: 72075186224037892] delete TxId 281474976715677
2025-10-26T18:05:53.623103Z node 3 :KQP_EXECUTER ERROR: TxId: 281474976715680. Ctx: { TraceId: 01k8gv5fe2e32asc0zaqzvmzyk, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=3&id=OGI5ZjBmYzgtZWMwZmUxNGQtY2VlZTU0YzYtMmQ3NmZhY2Y=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
===Query complete
TClient::Ls request: /Root/PQ/rt3.dc1--topic1
TClient::Ls response: Status: 1
StatusCode: SUCCESS
SchemeStatus: 0
PathDescription {
  Self {
    Name: "rt3.dc1--topic1"
    PathId: 9
    SchemeshardId: 72057594046644480
    PathType: EPathTypePersQueueGroup
    CreateFinished: true
    CreateTxId: 281474976715677
    CreateStep: 1761501953561
    ParentPathId: 2
    PathState: EPathStateNoChanges
    Owner: "root@builtin"
    ACL: ""
    EffectiveACL: ""
    PathVersion: 2
    PathSubType: EPathSubTypeEmpty
    Version {
      GeneralVersion: 2
      ACLVersion: 0
      EffectiveACLVersion: 0
      UserAttrsVersion: 1
      ChildrenVersion: 0
      PQVersion: 1
    }
    BalancerTabletID: 72075186224037894
  }
  PersQueueGroup {
    Name: "rt3.dc1--topic1"
    PathId: 9
    TotalGroupCount: 10
    PartitionPerTablet: 5
    PQTabletConfig {
      PartitionConfig {
        LifetimeSeconds: 86400
        LowWatermark: 8388608
        SourceIdLifetimeSeconds: 86400
        WriteSpeedInBytesPerSecond: 20000000
        BurstSize: 20000000
        SourceIdMax...
(TRUNCATED)
GetTopicVersionFromPath:  record Status: 1
StatusCode: SUCCESS
SchemeStatus: 0
PathDescription {
  Self {
    Name: "rt3.dc1--topic1"
    PathId: 9
    SchemeshardId: 72057594046644480
    PathType: EPathTypePersQueueGroup
    CreateFinished: true
    CreateTxId: 281474976715677
    CreateStep: 1761501953561
    ParentPathId: 2
    PathState: EPathStateNoChanges
    Owner: "root@builtin"
    ACL: ""
    EffectiveACL: ""
    PathVersion: 2
    PathSubType: EPathSubTypeEmpty
    Version {
      GeneralVersion: 2
      ACLVersion: 0
      EffectiveACLVersion: 0
      UserAttrsVersion: 1
      ChildrenVersion: 0
      PQVersion: 1
    }
    BalancerTabletID: 72075186224037894
  }
  PersQueueGroup {
    Name: "rt3.dc1--topic1"
    PathId: 9
    TotalGroupCount: 10
    PartitionPerTablet: 5
    PQTabletConfig {
      PartitionConfig {
        LifetimeSeconds: 86400
        LowWatermark: 8388608
        SourceIdLifetimeSeconds: 86400
        WriteSpeedInBytesPerSecond: 20000000
        BurstSize: 20000000
        SourceIdMaxCounts: 6000000
      }
      LocalDC: true
      ReadRules: "user"
      ReadFromTimestampsMs: 0
      ConsumerFormatVersions: 0
      ConsumerCodecs {
      }
      Codecs {
        Ids: 0
        Ids: 1
        Ids: 2
        Codecs: "raw"
        Codecs: "gzip"
        Codecs: "lzop"
      }
      ReadRuleVersions: 0
      YdbDatabasePath: "/Root"
    }
    Partitions {
      PartitionId: 0
      TabletId: 72075186224037892
      Status: Active
    }
    Partitions {
      PartitionId: 1
      TabletId: 72075186224037892
      Status: Active
    }
    Partitions {
      PartitionId: 2
      TabletId: 72075186224037893
      Status: Active
    }
    Partitions {
      PartitionId: 3
      TabletId: 72075186224037892
      Status: Active
    }
    Partitions {
      PartitionId: 4
      TabletId: 72075186224037893
      Status: Active
    }
    Partitions {
      PartitionId: 5
      TabletId: 72075186224037893
      Status: Active
    }
    Partitions {
      PartitionId: 6
      TabletId: 72075186224037892
      Status: Active
    }
    Partitions {
      PartitionId: 7
      TabletId: 72075186224037893
      Status: Active
    }
    Partitions {
      PartitionId: 8
      TabletId: 72075186224037892
      Status: Active
    }
    Partitions {
      PartitionId: 9
      TabletId: 72075186224037893
      Status: Active
    }
    AlterVersion: 1
    BalancerTabletID: 72075186224037894
    NextPartitionId: 10
  }
  DomainDescription {
    SchemeShardId_Depricated: 72057594046644480
    PathId_Depricated: 1
    ProcessingParams {
      Version: 1
      PlanResolution: 7
      Coordinators: 72057594046316545
      TimeCastBucketsPerMediator: 2
      Mediators: 72057594046382081
    }
    DomainKey {
      SchemeShard: 72057594046644480
      PathId: 1
    }
    PathsInside: 8
    PathsLimit: 10000
    ShardsInside: 7
    ShardsLimit: 200000
    ResourcesDomainKey {
      SchemeShard: 72057594046644480
      PathId: 1
    }
    DiskSpaceUsage {
      Tables {
        TotalSize: 0
        DataSize: 0
        IndexSize: 0
      }
      Topics {
        ReserveSize: 0
        AccountSize: 0
        DataSize: 0
        UsedReserveSize: 0
      }
    }
    PQPartitionsInside: 10
    PQPartitionsLimit: 1000000
  }
}
Path: "/Root/PQ/rt3.dc1--topic1"
 name rt3.dc1--topic1 version1
CallPersQueueGRPC request to localhost:28179
MetaRequest {
  CmdGetTopicMetadata {
    Topic: "rt3.dc1--topic1"
  }
}
CallPersQueueGRPC response:
Status: 128
ErrorReason: "the following topics are not created: rt3.dc1--topic1, Marker# PQ95"
ErrorCode: UNKNOWN_TOPIC
2025-10-26T18:05:53.655426Z node 3 :PERSQUEUE INFO: proxy answer <none>
CallPersQueueGRPC request to localhost:28179
MetaRequest {
  CmdGetTopicMetadata {
    Topic: "rt3.dc1--topic1"
  }
}
2025-10-26T18:05:54.161272Z node 3 :PERSQUEUE INFO: proxy answer <none>
CallPersQueueGRPC response:
Status: 128
ErrorReason: "the following topics are not created: rt3.dc1--topic1, Marker# PQ95"
ErrorCode: UNKNOWN_TOPIC
CallPersQueueGRPC request to localhost:28179
MetaRequest {
  CmdGetTopicMetadata {
    Topic: "rt3.dc1--topic1"
  }
}
2025-10-26T18:05:54.667964Z node 3 :PERSQUEUE INFO: proxy answer <none>
CallPersQueueGRPC response:
Status: 1
ErrorCode: OK
MetaResponse {
  CmdGetTopicMetadataResult {
    TopicInfo {
      Topic: "rt3.dc1--topic1"
      NumPartitions: 10
      Config {
        PartitionConfig {
          LifetimeSeconds: 86400
          LowWatermark: 8388608
          SourceIdLifetimeSeconds: 86400
          WriteSpeedInBytesPerSecond: 20000000
          BurstSize: 20000000
          SourceIdMaxCounts: 6000000
        }
        Version: 1
        LocalDC: true
        ReadRules: "user"
        ReadFromTimestampsMs: 0
        ConsumerFormatVersions: 0
        ConsumerCodecs {
        }
        Codecs {
          Ids: 0
          Ids: 1
          Ids: 2
          Codecs: "raw"
          Codecs: "gzip"
          Codecs: "lzop"
        }
        ReadRuleVersions: 0
        TopicPath: "/Root/PQ/rt3.dc1--topic1"
        YdbDatabasePath: "/Root"
        Consumers {
          Name: "user"
          ReadFromTimestampsMs: 0
          FormatVersion: 0
          Codec {
          }
          Version: 0
       ...
(TRUNCATED)
=== Topic created, have version: 1
2025-10-26T18:05:54.681728Z node 3 :PQ_WRITE_PROXY DEBUG: new grpc connection
2025-10-26T18:05:54.681771Z node 3 :PQ_WRITE_PROXY DEBUG: new session created cookie 1
2025-10-26T18:05:54.682179Z node 3 :PQ_WRITE_PROXY DEBUG: session v1 cookie: 1 sessionId:  grpc read done: success: 1 data: init_request { topic: "topic1" message_group_id: "12345678" }
2025-10-26T18:05:54.682315Z node 3 :PQ_WRITE_PROXY INFO: session request cookie: 1 topic: "topic1" message_group_id: "12345678" from ipv6:[::1]:48542
2025-10-26T18:05:54.682344Z node 3 :PQ_WRITE_PROXY INFO: write session:  cookie=1 sessionId= userAgent="pqv1 server" ip=ipv6:[::1]:48542 proto=v1  topic=topic1 durationSec=0
2025-10-26T18:05:54.682357Z node 3 :PQ_WRITE_PROXY INFO: init check schema
2025-10-26T18:05:54.684425Z node 3 :PQ_WRITE_PROXY INFO: session v1 cookie: 1 sessionId:  describe result for acl check
2025-10-26T18:05:54.684628Z node 3 :PQ_PARTITION_CHOOSER DEBUG: 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-10-26T18:05:54.684648Z node 3 :PQ_PARTITION_CHOOSER DEBUG: 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-10-26T18:05:54.684670Z node 3 :PQ_PARTITION_CHOOSER DEBUG: 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-10-26T18:05:54.684691Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264254:4350] (SourceId=12345678, PreferedPartition=(NULL)) StartKqpSession
2025-10-26T18:05:54.687355Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264254:4350] (SourceId=12345678, PreferedPartition=(NULL)) Select from the table
2025-10-26T18:05:54.839797Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264254:4350] (SourceId=12345678, PreferedPartition=(NULL)) RequestPQRB
2025-10-26T18:05:54.840597Z node 4 :PERSQUEUE_READ_BALANCER INFO: balancer: [72075186224037894] topic rt3.dc1--topic1 pipe [3:7565593287786264298:4350] connected; active server actors: 1
2025-10-26T18:05:54.841124Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264254:4350] (SourceId=12345678, PreferedPartition=(NULL)) Received partition 4 from PQRB for SourceId=12345678
2025-10-26T18:05:54.841162Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264254:4350] (SourceId=12345678, PreferedPartition=(NULL)) Update the table
2025-10-26T18:05:54.842634Z node 4 :PERSQUEUE_READ_BALANCER INFO: balancer: [72075186224037894] topic rt3.dc1--topic1 pipe [3:7565593287786264298:4350] disconnected; active server actors: 1
2025-10-26T18:05:54.842681Z node 4 :PERSQUEUE_READ_BALANCER INFO: balancer: [72075186224037894] topic rt3.dc1--topic1 pipe [3:7565593287786264298:4350] disconnected no session
2025-10-26T18:05:54.960625Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264254:4350] (SourceId=12345678, PreferedPartition=(NULL)) HandleUpdate PartitionPersisted=0 Status=SUCCESS
2025-10-26T18:05:54.960677Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264254:4350] (SourceId=12345678, PreferedPartition=(NULL)) ReplyResult: Partition=4, SeqNo=(NULL)
2025-10-26T18:05:54.960701Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264254:4350] (SourceId=12345678, PreferedPartition=(NULL)) Start idle
2025-10-26T18:05:54.960734Z node 3 :PQ_WRITE_PROXY DEBUG: ProceedPartition. session cookie: 1 sessionId:  partition: 4 expectedGeneration: (NULL)
2025-10-26T18:05:54.961392Z node 3 :PERSQUEUE DEBUG: Tablet 72075186224037893 server connected, pipe [3:7565593287786264320:4350], now have 1 active actors on pipe
2025-10-26T18:05:54.961403Z node 3 :PQ_WRITE_PROXY DEBUG: TPartitionWriter 72075186224037893 (partition=4) TEvClientConnected Status OK, TabletId: 72075186224037893, NodeId 3, Generation: 1
2025-10-26T18:05:54.961430Z node 3 :PERSQUEUE DEBUG: Handle TEvRequest topic: 'rt3.dc1--topic1' requestId: <none>
2025-10-26T18:05:54.961461Z node 3 :PERSQUEUE DEBUG: Tablet 72075186224037893 got client message batch for topic 'rt3.dc1--topic1' partition 4
2025-10-26T18:05:54.961559Z node 3 :PERSQUEUE INFO: new Cookie 12345678|31bd8a50-5e5e5421-18542852-28647b0f_0 generated for partition 4 topic 'rt3.dc1--topic1' owner 12345678
2025-10-26T18:05:54.961644Z node 3 :PERSQUEUE DEBUG: TPartition::ReplyOwnerOk. Partition: 4
2025-10-26T18:05:54.961731Z node 3 :PERSQUEUE DEBUG: Answer ok topic: 'rt3.dc1--topic1' partition: 4 messageNo: 0  requestId: <none> cookie: 0
2025-10-26T18:05:54.961876Z node 3 :PERSQUEUE DEBUG: Handle TEvRequest topic: 'rt3.dc1--topic1' requestId: <none>
2025-10-26T18:05:54.961891Z node 3 :PERSQUEUE DEBUG: Tablet 72075186224037893 got client message batch for topic 'rt3.dc1--topic1' partition 4
2025-10-26T18:05:54.961955Z node 3 :PERSQUEUE DEBUG: Answer ok topic: 'rt3.dc1--topic1' partition: 4 messageNo: 0  requestId: <none> cookie: 0
2025-10-26T18:05:54.962091Z node 3 :PQ_WRITE_PROXY INFO: session inited cookie: 1 partition: 4 MaxSeqNo: 0 sessionId: 12345678|31bd8a50-5e5e5421-18542852-28647b0f_0
2025-10-26T18:05:54.963086Z node 3 :PQ_WRITE_PROXY DEBUG: session v1 cookie: 1 sessionId: 12345678|31bd8a50-5e5e5421-18542852-28647b0f_0 grpc read done: success: 0 data: 
2025-10-26T18:05:54.963112Z node 3 :PQ_WRITE_PROXY INFO: session v1 cookie: 1 sessionId: 12345678|31bd8a50-5e5e5421-18542852-28647b0f_0 grpc read failed
2025-10-26T18:05:54.963325Z node 3 :PQ_WRITE_PROXY INFO: session v1 closed cookie: 1 sessionId: 12345678|31bd8a50-5e5e5421-18542852-28647b0f_0
2025-10-26T18:05:54.963349Z node 3 :PQ_WRITE_PROXY INFO: session v1 cookie: 1 sessionId: 12345678|31bd8a50-5e5e5421-18542852-28647b0f_0 is DEAD
2025-10-26T18:05:54.963740Z node 3 :PQ_WRITE_PROXY DEBUG: TPartitionWriter 72075186224037893 (partition=4) Received event: NActors::TEvents::TEvPoison
Finish: 0 
2025-10-26T18:05:54.963988Z node 3 :PERSQUEUE DEBUG: Tablet 72075186224037893 server disconnected, pipe [3:7565593287786264320:4350] destroyed
2025-10-26T18:05:54.964015Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 4, State: StateIdle] TPartition::DropOwner.
2025-10-26T18:05:54.977597Z :DEBUG: [] MessageGroupId [123] SessionId [] Write session: try to update token
2025-10-26T18:05:54.978062Z :INFO: [] MessageGroupId [123] SessionId [] Write session: Do CDS request
2025-10-26T18:05:54.979130Z :INFO: [] MessageGroupId [123] SessionId [] Start write session. Will connect to endpoint: localhost:28179
2025-10-26T18:05:54.989784Z :DEBUG: [] MessageGroupId [123] SessionId [] Write session: send init request: init_request { topic: "topic1" message_group_id: "123" }
2025-10-26T18:05:54.991057Z node 3 :PQ_WRITE_PROXY DEBUG: new grpc connection
2025-10-26T18:05:54.991102Z node 3 :PQ_WRITE_PROXY DEBUG: new session created cookie 2
2025-10-26T18:05:54.991466Z node 3 :PQ_WRITE_PROXY DEBUG: session v1 cookie: 2 sessionId:  grpc read done: success: 1 data: init_request { topic: "topic1" message_group_id: "123" }
2025-10-26T18:05:54.991566Z node 3 :PQ_WRITE_PROXY INFO: session request cookie: 2 topic: "topic1" message_group_id: "123" from ipv6:[::1]:48572
2025-10-26T18:05:54.991582Z node 3 :PQ_WRITE_PROXY INFO: write session:  cookie=2 sessionId= userAgent="pqv1 server" ip=ipv6:[::1]:48572 proto=v1  topic=topic1 durationSec=0
2025-10-26T18:05:54.991591Z node 3 :PQ_WRITE_PROXY INFO: init check schema
2025-10-26T18:05:54.993010Z node 3 :PQ_WRITE_PROXY INFO: session v1 cookie: 2 sessionId:  describe result for acl check
2025-10-26T18:05:54.993127Z node 3 :PQ_PARTITION_CHOOSER DEBUG: 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-10-26T18:05:54.993139Z node 3 :PQ_PARTITION_CHOOSER DEBUG: 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-10-26T18:05:54.993149Z node 3 :PQ_PARTITION_CHOOSER DEBUG: 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-10-26T18:05:54.993165Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264330:4284] (SourceId=123, PreferedPartition=(NULL)) StartKqpSession
2025-10-26T18:05:54.995251Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264330:4284] (SourceId=123, PreferedPartition=(NULL)) Select from the table
2025-10-26T18:05:55.002275Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264330:4284] (SourceId=123, PreferedPartition=(NULL)) RequestPQRB
2025-10-26T18:05:55.002950Z node 4 :PERSQUEUE_READ_BALANCER INFO: balancer: [72075186224037894] topic rt3.dc1--topic1 pipe [3:7565593292081231641:4284] connected; active server actors: 1
2025-10-26T18:05:55.003667Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264330:4284] (SourceId=123, PreferedPartition=(NULL)) Received partition 5 from PQRB for SourceId=123
2025-10-26T18:05:55.003692Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264330:4284] (SourceId=123, PreferedPartition=(NULL)) Update the table
2025-10-26T18:05:55.004279Z node 4 :PERSQUEUE_READ_BALANCER INFO: balancer: [72075186224037894] topic rt3.dc1--topic1 pipe [3:7565593292081231641:4284] disconnected; active server actors: 1
2025-10-26T18:05:55.004313Z node 4 :PERSQUEUE_READ_BALANCER INFO: balancer: [72075186224037894] topic rt3.dc1--topic1 pipe [3:7565593292081231641:4284] disconnected no session
2025-10-26T18:05:55.016012Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264330:4284] (SourceId=123, PreferedPartition=(NULL)) HandleUpdate PartitionPersisted=0 Status=SUCCESS
2025-10-26T18:05:55.016072Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264330:4284] (SourceId=123, PreferedPartition=(NULL)) ReplyResult: Partition=5, SeqNo=(NULL)
2025-10-26T18:05:55.016091Z node 3 :PQ_PARTITION_CHOOSER DEBUG: TPartitionChooser [3:7565593287786264330:4284] (SourceId=123, PreferedPartition=(NULL)) Start idle
2025-10-26T18:05:55.016133Z node 3 :PQ_WRITE_PROXY DEBUG: ProceedPartition. session cookie: 2 sessionId:  partition: 5 expectedGeneration: (NULL)
2025-10-26T18:05:55.016611Z node 3 :PERSQUEUE DEBUG: Tablet 72075186224037893 server connected, pipe [3:7565593292081231652:4284], now have 1 active actors on pipe
2025-10-26T18:05:55.016640Z node 3 :PQ_WRITE_PROXY DEBUG: TPartitionWriter 72075186224037893 (partition=5) TEvClientConnected Status OK, TabletId: 72075186224037893, NodeId 3, Generation: 1
2025-10-26T18:05:55.016664Z node 3 :PERSQUEUE DEBUG: Handle TEvRequest topic: 'rt3.dc1--topic1' requestId: <none>
2025-10-26T18:05:55.016681Z node 3 :PERSQUEUE DEBUG: Tablet 72075186224037893 got client message batch for topic 'rt3.dc1--topic1' partition 5
2025-10-26T18:05:55.016782Z node 3 :PERSQUEUE INFO: new Cookie 123|5b445526-d1057762-db2ea867-19448023_0 generated for partition 5 topic 'rt3.dc1--topic1' owner 123
2025-10-26T18:05:55.016880Z node 3 :PERSQUEUE DEBUG: TPartition::ReplyOwnerOk. Partition: 5
2025-10-26T18:05:55.016959Z node 3 :PERSQUEUE DEBUG: Answer ok topic: 'rt3.dc1--topic1' partition: 5 messageNo: 0  requestId: <none> cookie: 0
2025-10-26T18:05:55.017135Z node 3 :PERSQUEUE DEBUG: Handle TEvRequest topic: 'rt3.dc1--topic1' requestId: <none>
2025-10-26T18:05:55.017156Z node 3 :PERSQUEUE DEBUG: Tablet 72075186224037893 got client message batch for topic 'rt3.dc1--topic1' partition 5
2025-10-26T18:05:55.017266Z node 3 :PERSQUEUE DEBUG: Answer ok topic: 'rt3.dc1--topic1' partition: 5 messageNo: 0  requestId: <none> cookie: 0
2025-10-26T18:05:55.017382Z node 3 :PQ_WRITE_PROXY INFO: session inited cookie: 2 partition: 5 MaxSeqNo: 0 sessionId: 123|5b445526-d1057762-db2ea867-19448023_0
2025-10-26T18:05:55.018190Z :INFO: [] MessageGroupId [123] SessionId [] Counters: { Errors: 0 CurrentSessionLifetimeMs: 1761501955018 BytesWritten: 0 MessagesWritten: 0 BytesWrittenCompressed: 0 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
2025-10-26T18:05:55.018453Z :INFO: [] MessageGroupId [123] SessionId [] Write session established. Init response: session_id: "123|5b445526-d1057762-db2ea867-19448023_0" topic: "topic1" cluster: "dc1" partition_id: 5 supported_codecs: CODEC_RAW supported_codecs: CODEC_GZIP supported_codecs: CODEC_LZOP
ReadyToAcceptEvent
2025-10-26T18:05:55.277640Z node 3 :KQP_EXECUTER ERROR: TxId: 281474976715689. Ctx: { TraceId: 01k8gv5gytdnvrm2ng2ck4x9np, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=3&id=YTZmODg0NzItZTQ2ZjgwMTgtNjEyMzM4NDktMzBmOGUzNDY=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-10-26T18:05:55.286895Z node 3 :KQP_EXECUTER ERROR: TxId: 281474976715690. Ctx: { TraceId: 01k8gv5gytdnvrm2ng2ck4x9np, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=3&id=YTZmODg0NzItZTQ2ZjgwMTgtNjEyMzM4NDktMzBmOGUzNDY=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-10-26T18:05:55.951815Z :ERROR: [] MessageGroupId [123] SessionId [123|5b445526-d1057762-db2ea867-19448023_0] Got error. Status: UNAVAILABLE. Description: <main>: Error: cluster disabled, code: 500020 
2025-10-26T18:05:55.951882Z :ERROR: [] MessageGroupId [123] SessionId [123|5b445526-d1057762-db2ea867-19448023_0] Write session will not restart after a fatal error
2025-10-26T18:05:55.951916Z :INFO: [] MessageGroupId [123] SessionId [123|5b445526-d1057762-db2ea867-19448023_0] Write session will now close
2025-10-26T18:05:55.951968Z :DEBUG: [] MessageGroupId [123] SessionId [123|5b445526-d1057762-db2ea867-19448023_0] Write session: aborting
SessionClosed { Status: UNAVAILABLE Issues: "<main>: Error: cluster disabled, code: 500020 " }
is dead res: SessionClosed { Status: UNAVAILABLE Issues: "<main>: Error: cluster disabled, code: 500020 " }
2025-10-26T18:05:55.952930Z :DEBUG: [] MessageGroupId [123] SessionId [123|5b445526-d1057762-db2ea867-19448023_0] Write session: destroy
2025-10-26T18:05:55.950059Z node 3 :PQ_WRITE_PROXY INFO: session v1 error cookie: 2 reason: cluster disabled sessionId: 123|5b445526-d1057762-db2ea867-19448023_0
2025-10-26T18:05:55.950509Z node 3 :PQ_WRITE_PROXY INFO: session v1 cookie: 2 sessionId: 123|5b445526-d1057762-db2ea867-19448023_0 is DEAD
2025-10-26T18:05:55.950811Z node 3 :PQ_WRITE_PROXY DEBUG: TPartitionWriter 72075186224037893 (partition=5) Received event: NActors::TEvents::TEvPoison
2025-10-26T18:05:55.950913Z node 3 :PERSQUEUE DEBUG: Tablet 72075186224037893 server disconnected, pipe [3:7565593292081231652:4284] destroyed
2025-10-26T18:05:55.950950Z node 3 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 5, State: StateIdle] TPartition::DropOwner.
