2025-10-26T18:17:59.720994Z node 1 :METADATA_PROVIDER WARN: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[1:7565596399807669268:4098];send_to=[0:7307199536658146131:7762515];
2025-10-26T18:17:59.721876Z node 1 :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:17:59.742258Z node 2 :METADATA_PROVIDER WARN: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[2:7565596400166694908:4098];send_to=[0:7307199536658146131:7762515];
2025-10-26T18:17:59.743504Z node 2 :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:17:59.780425Z node 2 :PQ_READ_PROXY DEBUG: Direct read cache created
2025-10-26T18:17:59.803023Z node 1 :PQ_READ_PROXY DEBUG: Direct read cache created
test_client.cpp: SetPath # /home/runner/.ya/build/build_root/70hy/000514/r3tmp/tmpaphJuF/pdisk_1.dat
2025-10-26T18:18:00.199965Z node 1 :IMPORT WARN: Table profiles were not loaded
2025-10-26T18:18:00.229226Z node 1 :HIVE WARN: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-10-26T18:18:00.229351Z node 1 :HIVE WARN: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-10-26T18:18:00.231377Z node 1 :HIVE WARN: HIVE#72057594037968897 Node(2, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-10-26T18:18:00.231459Z node 1 :HIVE WARN: HIVE#72057594037968897 Node(2, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-10-26T18:18:00.237027Z node 1 :HIVE WARN: HIVE#72057594037968897 Handle TEvInterconnect::TEvNodeConnected, NodeId 2 Cookie 2
2025-10-26T18:18:00.237150Z node 1 :HIVE WARN: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-10-26T18:18:00.237847Z node 1 :HIVE WARN: HIVE#72057594037968897 Node(2, (0,0,0,0)) VolatileState: Connecting -> Connected
TServer::EnableGrpc on GrpcPort 64058, node 1
2025-10-26T18:18:00.305344Z node 1 :NET_CLASSIFIER WARN: distributable config is empty, broken or outdated, will use file: /home/runner/.ya/build/build_root/70hy/000514/r3tmp/yandex3P9pWe.tmp
2025-10-26T18:18:00.305372Z node 1 :NET_CLASSIFIER WARN: will try to initialize from file: /home/runner/.ya/build/build_root/70hy/000514/r3tmp/yandex3P9pWe.tmp
2025-10-26T18:18:00.305531Z node 1 :NET_CLASSIFIER WARN: successfully initialized from file: /home/runner/.ya/build/build_root/70hy/000514/r3tmp/yandex3P9pWe.tmp
2025-10-26T18:18:00.305670Z node 1 :NET_CLASSIFIER ERROR: got bad distributable configuration
2025-10-26T18:18:00.345100Z INFO: TTestServer started on Port 15786 GrpcPort 64058
TClient is connected to server localhost:15786
PQClient connected to localhost:64058
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:18:00.575496Z node 1 :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:18:00.621035Z node 1 :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:18:02.852721Z node 1 :KQP_COMPILE_ACTOR ERROR: Compilation failed, self: [1:7565596412692572155:4272], 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:18:02.853058Z node 1 :KQP_SESSION WARN: SessionId: ydb://session/3?node_id=1&id=MmIzMWJlNWUtMTdjZWFmYTYtZGEwYTdkNjgtODdlZDQyNTc=, ActorId: [1:7565596412692572153:4286], ActorState: ExecuteState, TraceId: 01k8gvvqj71gddbyfmrd3k8v4s, ReplyQueryCompileError, status SCHEME_ERROR remove tx with tx_id: 
2025-10-26T18:18:02.856108Z node 1 :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:18:02.856835Z node 1 :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:18:02.945773Z node 1 :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:18:03.045796Z node 1 :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:18:03.287077Z node 1 :KQP_EXECUTER ERROR: TxId: 281474976715665. Ctx: { TraceId: 01k8gvvqz822ggfy04k74n9cf4, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=YTdhNzU2ZTgtN2JiNDE0NzgtZWY1YzRiNzQtOTUzMzI2Yzc=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
=== CheckClustersList. Subcribe to ClusterTracker from [1:7565596416987539889:12337] 
2025-10-26T18:18:04.721156Z node 1 :METADATA_PROVIDER ERROR: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[1:7565596399807669268:4098];send_to=[0:7307199536658146131:7762515];
2025-10-26T18:18:04.721240Z node 1 :METADATA_PROVIDER ERROR: fline=accessor_snapshot_base.cpp:68;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=timeout;
2025-10-26T18:18:04.742696Z node 2 :METADATA_PROVIDER ERROR: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[2:7565596400166694908:4098];send_to=[0:7307199536658146131:7762515];
2025-10-26T18:18:04.742809Z node 2 :METADATA_PROVIDER ERROR: fline=accessor_snapshot_base.cpp:68;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=timeout;
=== CheckClustersList. Ok
CreateTopicNoLegacy: /Root/PQ/rt3.dc1--topic1
2025-10-26T18:18:08.959885Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Handle TEvTxProxySchemeCache::TEvNavigateKeySet: self# [1:7565596399807669495:8201], request# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path:  TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpPath RedirectRequired: false ShowPrivatePath: false SyncVersion: false Status: Unknown Kind: KindUnknown DomainInfo <null> }] }
2025-10-26T18:18:08.960030Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Send result: self# [1:7565596438462376732:8498], recipient# [1:7565596438462376731:8553], result# { ErrorCount: 1 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path:  TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpPath RedirectRequired: false ShowPrivatePath: false SyncVersion: false Status: RootUnknown Kind: KindUnknown DomainInfo <null> }] }
Create topic: /Root/PQ/rt3.dc1--topic1
AddTopic: /Root/PQ/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 = /Root/PQ/rt3.dc1/topic1, dc = unknown
2025-10-26T18:18:08.966404Z node 1 :KQP_PROXY DEBUG: TraceId: "01k8gvvxp6dz426dgs6zpgqvpp", Request has 4.998305s seconds to be completed
2025-10-26T18:18:08.966409Z node 1 :PQ_READ_PROXY DEBUG: new Create topic request
2025-10-26T18:18:08.966925Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Handle TEvTxProxySchemeCache::TEvNavigateKeySet: self# [1:7565596399807669495:8201], request# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpPath RedirectRequired: false ShowPrivatePath: false SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> },{ Path: Root/PQ TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpPath RedirectRequired: false ShowPrivatePath: false SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }] }
2025-10-26T18:18:08.967291Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: HandleNotify: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root PathId: <Invalid> Partial: 0 }
2025-10-26T18:18:08.967379Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: ResolveCacheItem: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root PathId: <Invalid> Partial: 0 }, by path# { Subscriber: { Subscriber: [1:7565596404102637264:8339] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 11 } Filled: 1 Status: StatusSuccess Kind: 2 TableKind: 0 Created: 1 CreateStep: 1761502680637 PathId: [OwnerId: 72057594046644480, LocalPathId: 1] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, by pathId# nullptr
2025-10-26T18:18:08.967469Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TNavigate: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596404102637264:8339] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 11 } Filled: 1 Status: StatusSuccess Kind: 2 TableKind: 0 Created: 1 CreateStep: 1761502680637 PathId: [OwnerId: 72057594046644480, LocalPathId: 1] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, entry# { Path: Root TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpPath RedirectRequired: false ShowPrivatePath: false SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }, props# { Cookie: 11 IsSync: true Partial: 0 }
2025-10-26T18:18:08.967509Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: HandleNotify: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ PathId: <Invalid> Partial: 0 }
2025-10-26T18:18:08.967555Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: ResolveCacheItem: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ PathId: <Invalid> Partial: 0 }, by path# { Subscriber: { Subscriber: [1:7565596404102637352:8392] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 9 } Filled: 1 Status: StatusSuccess Kind: 2 TableKind: 0 Created: 1 CreateStep: 1761502680651 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, by pathId# nullptr
2025-10-26T18:18:08.967622Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TNavigate: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596404102637352:8392] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 9 } Filled: 1 Status: StatusSuccess Kind: 2 TableKind: 0 Created: 1 CreateStep: 1761502680651 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, entry# { Path: Root/PQ TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpPath RedirectRequired: false ShowPrivatePath: false SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }, props# { Cookie: 9 IsSync: true Partial: 0 }
2025-10-26T18:18:08.967721Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [0:0:0], ActorState: unknown state, Create session actor with id ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==
2025-10-26T18:18:08.967786Z node 1 :KQP_PROXY DEBUG: TraceId: "01k8gvvxp6dz426dgs6zpgqvpp", Created new session, sessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, workerId: [1:7565596438462376737:4323], database: , longSession: 1, local sessions count: 1
2025-10-26T18:18:08.967834Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Send result: self# [1:7565596438462376736:8519], recipient# [1:7565596438462376735:8579], result# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root TableId: [72057594046644480:1:0] RequestType: ByPath Operation: OpPath RedirectRequired: false ShowPrivatePath: false SyncVersion: true Status: Ok Kind: KindPath DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } },{ Path: Root/PQ TableId: [72057594046644480:2:0] RequestType: ByPath Operation: OpPath RedirectRequired: false ShowPrivatePath: false SyncVersion: true Status: Ok Kind: KindPath DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } }] }
2025-10-26T18:18:08.967843Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: unknown state, session actor bootstrapped
2025-10-26T18:18:08.967888Z node 1 :KQP_PROXY DEBUG: Received create session request, trace_id: 01k8gvvxp6dz426dgs6zpgqvpp
2025-10-26T18:18:08.967973Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Handle TEvTxProxySchemeCache::TEvNavigateKeySet: self# [1:7565596399807669495:8201], request# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root/PQ TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpPath RedirectRequired: true ShowPrivatePath: true SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }] }
2025-10-26T18:18:08.968129Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: HandleNotify: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ PathId: <Invalid> Partial: 0 }
2025-10-26T18:18:08.968205Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: ResolveCacheItem: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ PathId: <Invalid> Partial: 0 }, by path# { Subscriber: { Subscriber: [1:7565596404102637352:8392] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 10 } Filled: 1 Status: StatusSuccess Kind: 2 TableKind: 0 Created: 1 CreateStep: 1761502680651 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, by pathId# nullptr
2025-10-26T18:18:08.968246Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TNavigate: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596404102637352:8392] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 10 } Filled: 1 Status: StatusSuccess Kind: 2 TableKind: 0 Created: 1 CreateStep: 1761502680651 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, entry# { Path: Root/PQ TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpPath RedirectRequired: true ShowPrivatePath: true SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }, props# { Cookie: 10 IsSync: true Partial: 0 }
2025-10-26T18:18:08.968366Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Send result: self# [1:7565596438462376738:8399], recipient# [1:7565596438462376735:8579], result# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root/PQ TableId: [72057594046644480:2:0] RequestType: ByPath Operation: OpPath RedirectRequired: true ShowPrivatePath: true SyncVersion: true Status: Ok Kind: KindPath DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } }] }
2025-10-26T18:18:08.972913Z node 1 :KQP_PROXY DEBUG: Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: , SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. TEvQueryRequest, set timer for: 300.000000s timeout: 0.000000s cancelAfter: 0.000000s. Send request to target, requestId: 15, targetId: [1:7565596438462376737:4323]
2025-10-26T18:18:08.972968Z node 1 :KQP_PROXY DEBUG: Scheduled timeout timer for requestId: 15 timeout: 300.000000s actor id: [1:7565596438462376746:8519]
2025-10-26T18:18:08.973141Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ReadyState, TraceId: 01k8gvvxpc6k0rmhnn1qg95738, received request, proxyRequestId: 15 prepared: 0 tx_control: 1 action: QUERY_ACTION_EXECUTE type: QUERY_TYPE_SQL_DML text: 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); rpcActor: [1:7565596438462376744:8516] database:  databaseId: /Root pool id: 
2025-10-26T18:18:08.973218Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ReadyState, TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Sending CompileQuery request
2025-10-26T18:18:08.974082Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: HandleNotify: self# [1:7565596399807669495:8201], notify# NKikimr::TSchemeBoardEvents::TEvNotifyUpdate { Path: /Root/PQ PathId: [OwnerId: 72057594046644480, LocalPathId: 2] DescribeSchemeResult: Status: StatusSuccess Path: "/Root/PQ" PathDescription { Self { Name: "PQ" PathId: 2 SchemeshardId: 72057594046644480 PathType: EPathTypeDir CreateFinished: true CreateTxId: 281474976715658 CreateStep: 1761502680651 ParentPathId: 1 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "" EffectiveACL: "" PathVersion: 8 PathSubType: EPathSubTypeEmpty Version { GeneralVersion: 8 ACLVersion: 0 EffectiveACLVersion: 0 UserAttrsVersion: 1 ChildrenVersion: 7 } } Children { Name: "Config" PathId: 4 SchemeshardId: 72057594046644480 PathType: EPathTypeDir CreateFinished: true CreateTxId: 281474976715660 CreateStep: 1761502680819 ParentPathId: 2 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "" } Children { Name: "SourceIdMeta2" PathId: 3 SchemeshardId: 72057594046644480 PathType: EPathTypeTable CreateFinished: true CreateTxId: 281474976715659 CreateStep: 1761502680770 ParentPathId: 2 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "" } Children { Name: "rt3.dc1--topic1" PathId: 9 SchemeshardId: 72057594046644480 PathType: EPathTypePersQueueGroup CreateFinished: false CreateTxId: 281474976715671 ParentPathId: 2 PathState: EPathStateCreate Owner: "root@builtin" } 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: 8 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: 5 PQPartitionsLimit: 1000000 } } PathId: 2 PathOwnerId: 72057594046644480 }
2025-10-26T18:18:08.974449Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: ResolveCacheItem: self# [1:7565596399807669495:8201], notify# NKikimr::TSchemeBoardEvents::TEvNotifyUpdate { Path: /Root/PQ PathId: [OwnerId: 72057594046644480, LocalPathId: 2] DescribeSchemeResult: Status: StatusSuccess Path: "/Root/PQ" PathDescription { Self { Name: "PQ" PathId: 2 SchemeshardId: 72057594046644480 PathType: EPathTypeDir CreateFinished: true CreateTxId: 281474976715658 CreateStep: 1761502680651 ParentPathId: 1 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "" EffectiveACL: "" PathVersion: 8 PathSubType: EPathSubTypeEmpty Version { GeneralVersion: 8 ACLVersion: 0 EffectiveACLVersion: 0 UserAttrsVersion: 1 ChildrenVersion: 7 } } Children { Name: "Config" PathId: 4 SchemeshardId: 72057594046644480 PathType: EPathTypeDir CreateFinished: true CreateTxId: 281474976715660 CreateStep: 1761502680819 ParentPathId: 2 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "" } Children { Name: "SourceIdMeta2" PathId: 3 SchemeshardId: 72057594046644480 PathType: EPathTypeTable CreateFinished: true CreateTxId: 281474976715659 CreateStep: 1761502680770 ParentPathId: 2 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "" } Children { Name: "rt3.dc1--topic1" PathId: 9 SchemeshardId: 72057594046644480 PathType: EPathTypePersQueueGroup CreateFinished: false CreateTxId: 281474976715671 ParentPathId: 2 PathState: EPathStateCreate Owner: "root@builtin" } 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: 8 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: 5 PQPartitionsLimit: 1000000 } } PathId: 2 PathOwnerId: 72057594046644480 }, by path# { Subscriber: { Subscriber: [1:7565596404102637352:8392] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 10 } Filled: 1 Status: StatusSuccess Kind: 2 TableKind: 0 Created: 1 CreateStep: 1761502680651 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, by pathId# { Subscriber: { Subscriber: [1:7565596404102637352:8392] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 10 } Filled: 1 Status: StatusSuccess Kind: 2 TableKind: 0 Created: 1 CreateStep: 1761502680651 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }
2025-10-26T18:18:08.994422Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Handle TEvTxProxySchemeCache::TEvNavigateKeySet: self# [1:7565596399807669495:8201], request# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root/PQ/Config/V2/Versions TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpTable RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> },{ Path: Root/PQ/Config/V2/Versions TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpUnknown RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }] }
2025-10-26T18:18:08.994502Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Handle TEvTxProxySchemeCache::TEvNavigateKeySet: self# [1:7565596399807669495:8201], request# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root/PQ/Config/V2/Topics TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpTable RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> },{ Path: Root/PQ/Config/V2/Topics TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpUnknown RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }] }
2025-10-26T18:18:08.995314Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: HandleNotify: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ/Config/V2/Versions PathId: <Invalid> Partial: 0 }
2025-10-26T18:18:08.995396Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: ResolveCacheItem: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ/Config/V2/Versions PathId: <Invalid> Partial: 0 }, by path# { Subscriber: { Subscriber: [1:7565596412692572172:8319] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 18 } Filled: 1 Status: StatusSuccess Kind: 3 TableKind: 1 Created: 1 CreateStep: 1761502683122 PathId: [OwnerId: 72057594046644480, LocalPathId: 8] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 1 }, by pathId# nullptr
2025-10-26T18:18:08.995474Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TNavigate: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596412692572172:8319] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 18 } Filled: 1 Status: StatusSuccess Kind: 3 TableKind: 1 Created: 1 CreateStep: 1761502683122 PathId: [OwnerId: 72057594046644480, LocalPathId: 8] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 1 }, entry# { Path: Root/PQ/Config/V2/Versions TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpTable RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }, props# { Cookie: 17 IsSync: true Partial: 0 }
2025-10-26T18:18:08.995523Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: HandleNotify: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ/Config/V2/Topics PathId: <Invalid> Partial: 0 }
2025-10-26T18:18:08.995576Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: ResolveCacheItem: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ/Config/V2/Topics PathId: <Invalid> Partial: 0 }, by path# { Subscriber: { Subscriber: [1:7565596412692572171:8441] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 4 } Filled: 1 Status: StatusSuccess Kind: 3 TableKind: 1 Created: 1 CreateStep: 1761502683031 PathId: [OwnerId: 72057594046644480, LocalPathId: 7] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 1 }, by pathId# nullptr
2025-10-26T18:18:08.995630Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TNavigate: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596412692572171:8441] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 4 } Filled: 1 Status: StatusSuccess Kind: 3 TableKind: 1 Created: 1 CreateStep: 1761502683031 PathId: [OwnerId: 72057594046644480, LocalPathId: 7] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 1 }, entry# { Path: Root/PQ/Config/V2/Topics TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpTable RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }, props# { Cookie: 3 IsSync: true Partial: 0 }
2025-10-26T18:18:08.995791Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: HandleNotify: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ/Config/V2/Versions PathId: <Invalid> Partial: 0 }
2025-10-26T18:18:08.995854Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: ResolveCacheItem: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ/Config/V2/Versions PathId: <Invalid> Partial: 0 }, by path# { Subscriber: { Subscriber: [1:7565596412692572172:8319] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 18 } Filled: 1 Status: StatusSuccess Kind: 3 TableKind: 1 Created: 1 CreateStep: 1761502683122 PathId: [OwnerId: 72057594046644480, LocalPathId: 8] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 1 }, by pathId# nullptr
2025-10-26T18:18:08.995908Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TNavigate: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596412692572172:8319] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 18 } Filled: 1 Status: StatusSuccess Kind: 3 TableKind: 1 Created: 1 CreateStep: 1761502683122 PathId: [OwnerId: 72057594046644480, LocalPathId: 8] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 1 }, entry# { Path: Root/PQ/Config/V2/Versions TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpUnknown RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }, props# { Cookie: 18 IsSync: true Partial: 0 }
2025-10-26T18:18:08.995966Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: HandleNotify: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ/Config/V2/Topics PathId: <Invalid> Partial: 0 }
2025-10-26T18:18:08.996022Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: ResolveCacheItem: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ/Config/V2/Topics PathId: <Invalid> Partial: 0 }, by path# { Subscriber: { Subscriber: [1:7565596412692572171:8441] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 4 } Filled: 1 Status: StatusSuccess Kind: 3 TableKind: 1 Created: 1 CreateStep: 1761502683031 PathId: [OwnerId: 72057594046644480, LocalPathId: 7] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 1 }, by pathId# nullptr
2025-10-26T18:18:08.996074Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TNavigate: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596412692572171:8441] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 4 } Filled: 1 Status: StatusSuccess Kind: 3 TableKind: 1 Created: 1 CreateStep: 1761502683031 PathId: [OwnerId: 72057594046644480, LocalPathId: 7] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 1 }, entry# { Path: Root/PQ/Config/V2/Topics TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpUnknown RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }, props# { Cookie: 4 IsSync: true Partial: 0 }
2025-10-26T18:18:08.996330Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Send result: self# [1:7565596438462376801:8416], recipient# [1:7565596438462376790:4302], result# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root/PQ/Config/V2/Versions TableId: [72057594046644480:8:1] RequestType: ByPath Operation: OpTable RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: Ok Kind: KindTable DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } },{ Path: Root/PQ/Config/V2/Versions TableId: [72057594046644480:8:1] RequestType: ByPath Operation: OpUnknown RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: Ok Kind: KindTable DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } }] }
2025-10-26T18:18:08.996345Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Send result: self# [1:7565596438462376803:8610], recipient# [1:7565596438462376791:4301], result# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root/PQ/Config/V2/Topics TableId: [72057594046644480:7:1] RequestType: ByPath Operation: OpTable RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: Ok Kind: KindTable DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } },{ Path: Root/PQ/Config/V2/Topics TableId: [72057594046644480:7:1] RequestType: ByPath Operation: OpUnknown RedirectRequired: true ShowPrivatePath: false SyncVersion: true Status: Ok Kind: KindTable DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } }] }
2025-10-26T18:18:08.996597Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Handle TEvTxProxySchemeCache::TEvNavigateKeySet: self# [1:7565596399807669495:8201], request# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path:  TableId: [72057594046644480:7:0] RequestType: ByTableId Operation: OpPath RedirectRequired: true ShowPrivatePath: true SyncVersion: false Status: Unknown Kind: KindUnknown DomainInfo <null> }] }
2025-10-26T18:18:08.996696Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TNavigate: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596412692572171:8441] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 4 } Filled: 1 Status: StatusSuccess Kind: 3 TableKind: 1 Created: 1 CreateStep: 1761502683031 PathId: [OwnerId: 72057594046644480, LocalPathId: 7] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 1 }, entry# { Path:  TableId: [72057594046644480:7:0] RequestType: ByTableId Operation: OpPath RedirectRequired: true ShowPrivatePath: true SyncVersion: false Status: Unknown Kind: KindUnknown DomainInfo <null> }, props# { Cookie: 0 IsSync: false Partial: 0 }
2025-10-26T18:18:08.996766Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Handle TEvTxProxySchemeCache::TEvNavigateKeySet: self# [1:7565596399807669495:8201], request# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path:  TableId: [72057594046644480:8:0] RequestType: ByTableId Operation: OpPath RedirectRequired: true ShowPrivatePath: true SyncVersion: false Status: Unknown Kind: KindUnknown DomainInfo <null> }] }
2025-10-26T18:18:08.996840Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TNavigate: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596412692572172:8319] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 18 } Filled: 1 Status: StatusSuccess Kind: 3 TableKind: 1 Created: 1 CreateStep: 1761502683122 PathId: [OwnerId: 72057594046644480, LocalPathId: 8] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 1 }, entry# { Path:  TableId: [72057594046644480:8:0] RequestType: ByTableId Operation: OpPath RedirectRequired: true ShowPrivatePath: true SyncVersion: false Status: Unknown Kind: KindUnknown DomainInfo <null> }, props# { Cookie: 0 IsSync: false Partial: 0 }
2025-10-26T18:18:08.996997Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Send result: self# [1:7565596438462376808:8352], recipient# [1:7565596399807669203:8194], result# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root/PQ/Config/V2/Topics TableId: [72057594046644480:7:1] RequestType: ByTableId Operation: OpPath RedirectRequired: true ShowPrivatePath: true SyncVersion: false Status: Ok Kind: KindTable DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } }] }
2025-10-26T18:18:08.997054Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Send result: self# [1:7565596438462376809:8455], recipient# [1:7565596399807669203:8194], result# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root/PQ/Config/V2/Versions TableId: [72057594046644480:8:1] RequestType: ByTableId Operation: OpPath RedirectRequired: true ShowPrivatePath: true SyncVersion: false Status: Ok Kind: KindTable DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } }] }
2025-10-26T18:18:08.997269Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Handle TEvTxProxySchemeCache::TEvNavigateKeySet: self# [1:7565596399807669495:8201], request# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path:  TableId: [72057594046644480:1:0] RequestType: ByTableId Operation: OpPath RedirectRequired: false ShowPrivatePath: true SyncVersion: false Status: Unknown Kind: KindUnknown DomainInfo <null> }] }
2025-10-26T18:18:08.997326Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TNavigate: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596404102637264:8339] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 11 } Filled: 1 Status: StatusSuccess Kind: 2 TableKind: 0 Created: 1 CreateStep: 1761502680637 PathId: [OwnerId: 72057594046644480, LocalPathId: 1] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, entry# { Path:  TableId: [72057594046644480:1:0] RequestType: ByTableId Operation: OpPath RedirectRequired: false ShowPrivatePath: true SyncVersion: false Status: Unknown Kind: KindUnknown DomainInfo <null> }, props# { Cookie: 0 IsSync: false Partial: 0 }
2025-10-26T18:18:08.997407Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Send result: self# [1:7565596438462376812:8442], recipient# [1:7565596399807669203:8194], result# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root TableId: [72057594046644480:1:0] RequestType: ByTableId Operation: OpPath RedirectRequired: false ShowPrivatePath: true SyncVersion: false Status: Ok Kind: KindPath DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } }] }
2025-10-26T18:18:09.016118Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Handle TEvInterconnect::TEvNodeInfo
2025-10-26T18:18:09.016466Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Registered with mediator time cast
2025-10-26T18:18:09.016612Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvInterconnect::TEvNodeInfo
2025-10-26T18:18:09.016864Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Registered with mediator time cast
2025-10-26T18:18:09.017059Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvInterconnect::TEvNodeInfo
2025-10-26T18:18:09.017097Z node 2 :PERSQUEUE_READ_BALANCER INFO: balancer: [72075186224037895] topic  pipe [1:7565596438462376816:8471] connected; active server actors: 1
2025-10-26T18:18:09.018886Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Registered with mediator time cast
2025-10-26T18:18:09.019295Z node 2 :PERSQUEUE_READ_BALANCER DEBUG: balancer: [72075186224037895] topic rt3.dc1--topic1 updating configuration. Deleted partitions []. Added partitions [1, 2, 3, 4, 0]
2025-10-26T18:18:09.020133Z node 2 :PERSQUEUE_READ_BALANCER DEBUG: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at RB 72075186224037895
2025-10-26T18:18:09.022986Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Transactions request. From tx_00000000000000000000, To tx_18446744073709551615
2025-10-26T18:18:09.023285Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] doesn't have tx info
2025-10-26T18:18:09.023317Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] PlanStep 0, PlanTxId 0, ExecStep 0, ExecTxId 0
2025-10-26T18:18:09.023335Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] no config, start with empty partitions and default config
2025-10-26T18:18:09.023369Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Txs.size=0, PlannedTxs.size=0
2025-10-26T18:18:09.023414Z node 1 :PERSQUEUE NOTICE: Tablet 72075186224037894 disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-10-26T18:18:09.023456Z node 1 :PERSQUEUE INFO: Tablet 72075186224037894 doesn't have tx writes info
2025-10-26T18:18:09.023094Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Transactions request. From tx_00000000000000000000, To tx_18446744073709551615
2025-10-26T18:18:09.023323Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] doesn't have tx info
2025-10-26T18:18:09.023346Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] PlanStep 0, PlanTxId 0, ExecStep 0, ExecTxId 0
2025-10-26T18:18:09.023377Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] no config, start with empty partitions and default config
2025-10-26T18:18:09.023407Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Txs.size=0, PlannedTxs.size=0
2025-10-26T18:18:09.023449Z node 2 :PERSQUEUE NOTICE: Tablet 72075186224037892 disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-10-26T18:18:09.023481Z node 2 :PERSQUEUE INFO: Tablet 72075186224037892 doesn't have tx writes info
2025-10-26T18:18:09.023956Z node 2 :PERSQUEUE_READ_BALANCER DEBUG: tablet 72075186224037895 topic rt3.dc1--topic1 TEvClientConnected TabletId 72075186224037892, NodeId 2, Generation 1
2025-10-26T18:18:09.023965Z node 2 :PERSQUEUE DEBUG: Tablet 72075186224037892 server connected, pipe [2:7565596443116368342:8], now have 1 active actors on pipe
2025-10-26T18:18:09.024186Z node 2 :PERSQUEUE_READ_BALANCER DEBUG: BALANCER INIT DONE for rt3.dc1--topic1: (0, 72075186224037894) (1, 72075186224037892) (2, 72075186224037892) (3, 72075186224037893) (4, 72075186224037893) 
2025-10-26T18:18:09.024371Z node 2 :PERSQUEUE DEBUG: Tablet 72075186224037892 server connected, pipe [1:7565596438462376813:8416], now have 1 active actors on pipe
2025-10-26T18:18:09.024549Z node 2 :PERSQUEUE_READ_BALANCER DEBUG: tablet 72075186224037895 topic rt3.dc1--topic1 TEvClientConnected TabletId 72075186224037894, NodeId 1, Generation 1
2025-10-26T18:18:09.024619Z node 2 :PERSQUEUE_READ_BALANCER DEBUG: tablet 72075186224037895 topic rt3.dc1--topic1 TEvClientConnected TabletId 72075186224037893, NodeId 1, Generation 1
2025-10-26T18:18:09.025125Z node 2 :PERSQUEUE_READ_BALANCER DEBUG: tablet 72075186224037895 topic rt3.dc1--topic1 TEvClientConnected TabletId 72057594046644480, NodeId 1, Generation 2
2025-10-26T18:18:09.023589Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Transactions request. From tx_00000000000000000000, To tx_18446744073709551615
2025-10-26T18:18:09.023716Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] doesn't have tx info
2025-10-26T18:18:09.023730Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] PlanStep 0, PlanTxId 0, ExecStep 0, ExecTxId 0
2025-10-26T18:18:09.023749Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] no config, start with empty partitions and default config
2025-10-26T18:18:09.023763Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Txs.size=0, PlannedTxs.size=0
2025-10-26T18:18:09.023778Z node 1 :PERSQUEUE NOTICE: Tablet 72075186224037893 disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-10-26T18:18:09.023794Z node 1 :PERSQUEUE INFO: Tablet 72075186224037893 doesn't have tx writes info
2025-10-26T18:18:09.023843Z node 1 :PERSQUEUE DEBUG: Tablet 72075186224037894 server connected, pipe [1:7565596438462376815:8612], now have 1 active actors on pipe
2025-10-26T18:18:09.023860Z node 1 :PERSQUEUE DEBUG: Tablet 72075186224037894 server connected, pipe [2:7565596443116368341:8], now have 1 active actors on pipe
2025-10-26T18:18:09.038871Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Handle TEvPersQueue::TEvProposeTransaction SourceActor { RawX1: 7565596399807669604 RawX2: 4294979629 } TxId: 281474976715671 Config { TabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 0 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } } }
2025-10-26T18:18:09.039117Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Propose TxId 281474976715671, WriteId (empty maybe)
2025-10-26T18:18:09.039177Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Try execute txs with state UNKNOWN
2025-10-26T18:18:09.039206Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, State UNKNOWN
2025-10-26T18:18:09.039231Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] schedule TEvProposeTransactionResult(PREPARED)
2025-10-26T18:18:09.039261Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, NewState PREPARING
2025-10-26T18:18:09.039184Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPersQueue::TEvProposeTransaction SourceActor { RawX1: 7565596399807669604 RawX2: 4294979629 } TxId: 281474976715671 Config { TabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 1 PartitionIds: 2 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 1 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 2 Status: Active CreateVersion: 1 TabletId: 0 } Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } } }
2025-10-26T18:18:09.039336Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Propose TxId 281474976715671, WriteId (empty maybe)
2025-10-26T18:18:09.039389Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state UNKNOWN
2025-10-26T18:18:09.039386Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] write key for TxId 281474976715671
2025-10-26T18:18:09.039438Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, State UNKNOWN
2025-10-26T18:18:09.039469Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] schedule TEvProposeTransactionResult(PREPARED)
2025-10-26T18:18:09.039517Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, NewState PREPARING
2025-10-26T18:18:09.039586Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] write key for TxId 281474976715671
2025-10-26T18:18:09.039999Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] save tx TxId: 281474976715671 State: PREPARED MinStep: 1 MaxStep: 18446744073709551615 Kind: KIND_CONFIG TabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 0 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 ReadRuleGenerations: 0 ReadRuleGenerations: 0 Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565596399807669604 RawX2: 4294979629 }
2025-10-26T18:18:09.040162Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:18:09.040352Z node 2 :PERSQUEUE DEBUG: [TxId: 281474976715671] save tx TxId: 281474976715671 State: PREPARED MinStep: 1761502689000 MaxStep: 18446744073709551615 Kind: KIND_CONFIG TabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 1 PartitionIds: 2 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 1 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 2 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 ReadRuleGenerations: 0 ReadRuleGenerations: 0 Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565596399807669604 RawX2: 4294979629 }
2025-10-26T18:18:09.040445Z node 1 :PERSQUEUE DEBUG: Tablet 72075186224037893 server connected, pipe [1:7565596438462376814:8611], now have 1 active actors on pipe
2025-10-26T18:18:09.040510Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:18:09.040977Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPersQueue::TEvProposeTransaction SourceActor { RawX1: 7565596399807669604 RawX2: 4294979629 } TxId: 281474976715671 Config { TabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 3 PartitionIds: 4 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 3 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 4 Status: Active CreateVersion: 1 TabletId: 0 } Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } } }
2025-10-26T18:18:09.041076Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Propose TxId 281474976715671, WriteId (empty maybe)
2025-10-26T18:18:09.041098Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state UNKNOWN
2025-10-26T18:18:09.041109Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, State UNKNOWN
2025-10-26T18:18:09.041123Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] schedule TEvProposeTransactionResult(PREPARED)
2025-10-26T18:18:09.041137Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, NewState PREPARING
2025-10-26T18:18:09.041188Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] write key for TxId 281474976715671
2025-10-26T18:18:09.041641Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] save tx TxId: 281474976715671 State: PREPARED MinStep: 1761502689000 MaxStep: 18446744073709551615 Kind: KIND_CONFIG TabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 3 PartitionIds: 4 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 3 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 4 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 ReadRuleGenerations: 0 ReadRuleGenerations: 0 Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565596399807669604 RawX2: 4294979629 }
2025-10-26T18:18:09.041750Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:18:09.041787Z node 1 :PERSQUEUE DEBUG: Tablet 72075186224037893 server connected, pipe [2:7565596443116368343:8], now have 1 active actors on pipe
2025-10-26T18:18:09.043880Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:18:09.043922Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Try execute txs with state PREPARING
2025-10-26T18:18:09.043948Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, State PREPARING
2025-10-26T18:18:09.043968Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, NewState PREPARED
2025-10-26T18:18:09.044261Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:18:09.044316Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state PREPARING
2025-10-26T18:18:09.044329Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, State PREPARING
2025-10-26T18:18:09.044343Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, NewState PREPARED
2025-10-26T18:18:09.044762Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:18:09.044788Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state PREPARING
2025-10-26T18:18:09.044799Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, State PREPARING
2025-10-26T18:18:09.044810Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, NewState PREPARED
2025-10-26T18:18:09.048014Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPersQueue::TEvProposeTransactionAttach TabletId: 72075186224037893 TxId: 281474976715671
2025-10-26T18:18:09.048082Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Handle TEvPersQueue::TEvProposeTransactionAttach TabletId: 72075186224037894 TxId: 281474976715671
2025-10-26T18:18:09.048109Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPersQueue::TEvProposeTransactionAttach TabletId: 72075186224037892 TxId: 281474976715671
2025-10-26T18:18:09.050705Z node 1 :PERSQUEUE DEBUG: Tablet 72075186224037893 server connected, pipe [1:7565596442757344264:8380], now have 1 active actors on pipe
2025-10-26T18:18:09.050747Z node 1 :PERSQUEUE DEBUG: Tablet 72075186224037894 server connected, pipe [1:7565596442757344266:8600], now have 1 active actors on pipe
2025-10-26T18:18:09.050816Z node 2 :PERSQUEUE DEBUG: Tablet 72075186224037892 server connected, pipe [1:7565596442757344265:8382], now have 1 active actors on pipe
2025-10-26T18:18:09.054500Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvTxProcessing::TEvPlanStep Transactions { TxId: 281474976715671 AckTo { RawX1: 7565596404102637152 RawX2: 4294975582 } } Step: 1761502689093 MediatorID: 72057594046382081 TabletID: 72075186224037893
2025-10-26T18:18:09.054554Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state PREPARED
2025-10-26T18:18:09.054512Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvTxProcessing::TEvPlanStep Transactions { TxId: 281474976715671 AckTo { RawX1: 7565596404102637152 RawX2: 4294975582 } } Step: 1761502689093 MediatorID: 72057594046382081 TabletID: 72075186224037892
2025-10-26T18:18:09.054585Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, State PREPARED
2025-10-26T18:18:09.054562Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state PREPARED
2025-10-26T18:18:09.054605Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, NewState PLANNING
2025-10-26T18:18:09.054594Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, State PREPARED
2025-10-26T18:18:09.054610Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, NewState PLANNING
2025-10-26T18:18:09.054663Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] PlanStep 1761502689093, PlanTxId 281474976715671
2025-10-26T18:18:09.054646Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] PlanStep 1761502689093, PlanTxId 281474976715671
2025-10-26T18:18:09.054700Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] write key for TxId 281474976715671
2025-10-26T18:18:09.054697Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] write key for TxId 281474976715671
2025-10-26T18:18:09.055295Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] save tx TxId: 281474976715671 State: PLANNED MinStep: 1761502689000 MaxStep: 18446744073709551615 Step: 1761502689093 Kind: KIND_CONFIG TabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 3 PartitionIds: 4 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 3 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 4 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 ReadRuleGenerations: 0 ReadRuleGenerations: 0 Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565596399807669604 RawX2: 4294979629 }
2025-10-26T18:18:09.055385Z node 2 :PERSQUEUE DEBUG: [TxId: 281474976715671] save tx TxId: 281474976715671 State: PLANNED MinStep: 1761502689000 MaxStep: 18446744073709551615 Step: 1761502689093 Kind: KIND_CONFIG TabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 1 PartitionIds: 2 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 1 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 2 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 ReadRuleGenerations: 0 ReadRuleGenerations: 0 Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565596399807669604 RawX2: 4294979629 }
2025-10-26T18:18:09.055501Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:18:09.055483Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:18:09.055714Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Handle TEvTxProcessing::TEvPlanStep Transactions { TxId: 281474976715671 AckTo { RawX1: 7565596404102637152 RawX2: 4294975582 } } Step: 1761502689093 MediatorID: 72057594046382081 TabletID: 72075186224037894
2025-10-26T18:18:09.055747Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Try execute txs with state PREPARED
2025-10-26T18:18:09.055758Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, State PREPARED
2025-10-26T18:18:09.055774Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, NewState PLANNING
2025-10-26T18:18:09.055789Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] PlanStep 1761502689093, PlanTxId 281474976715671
2025-10-26T18:18:09.055809Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] write key for TxId 281474976715671
2025-10-26T18:18:09.056292Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] save tx TxId: 281474976715671 State: PLANNED MinStep: 1 MaxStep: 18446744073709551615 Step: 1761502689093 Kind: KIND_CONFIG TabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 0 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 ReadRuleGenerations: 0 ReadRuleGenerations: 0 Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565596399807669604 RawX2: 4294979629 }
2025-10-26T18:18:09.056393Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:18:09.058937Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:18:09.058995Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state PLANNING
2025-10-26T18:18:09.059017Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, State PLANNING
2025-10-26T18:18:09.059046Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, NewState PLANNED
2025-10-26T18:18:09.059072Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671 moved from PLANNING to PLANNED
2025-10-26T18:18:09.059088Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxQueue.size 1
2025-10-26T18:18:09.059105Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] New ExecStep 1761502689093, ExecTxId 281474976715671
2025-10-26T18:18:09.059099Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:18:09.059155Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state PLANNING
2025-10-26T18:18:09.059178Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, State PLANNING
2025-10-26T18:18:09.059192Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, NewState PLANNED
2025-10-26T18:18:09.059215Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671 moved from PLANNING to PLANNED
2025-10-26T18:18:09.059228Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxQueue.size 1
2025-10-26T18:18:09.059245Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] New ExecStep 1761502689093, ExecTxId 281474976715671
2025-10-26T18:18:09.060369Z node 2 :PERSQUEUE DEBUG: Initializing topic 'PQ/rt3.dc1--topic1' partition 1. Step TInitConfigStep
2025-10-26T18:18:09.061259Z node 2 :PERSQUEUE DEBUG: Initializing topic 'PQ/rt3.dc1--topic1' partition 2. Step TInitConfigStep
2025-10-26T18:18:09.061354Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, NewState CALCULATING
2025-10-26T18:18:09.061430Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671 moved from PLANNED to CALCULATING
2025-10-26T18:18:09.061441Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 2, State: StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-26T18:18:09.061449Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, NewState CALCULATING
2025-10-26T18:18:09.061470Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671 moved from PLANNED to CALCULATING
2025-10-26T18:18:09.061501Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 1, State: StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-26T18:18:09.061602Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:18:09.061639Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Try execute txs with state PLANNING
2025-10-26T18:18:09.061651Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, State PLANNING
2025-10-26T18:18:09.061663Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, NewState PLANNED
2025-10-26T18:18:09.061677Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671 moved from PLANNING to PLANNED
2025-10-26T18:18:09.061704Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxQueue.size 1
2025-10-26T18:18:09.061747Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] New ExecStep 1761502689093, ExecTxId 281474976715671
2025-10-26T18:18:09.061899Z node 2 :PERSQUEUE DEBUG: Initializing topic 'PQ/rt3.dc1--topic1' partition 1. Step TInitInternalFieldsStep
2025-10-26T18:18:09.061997Z node 2 :PERSQUEUE DEBUG: Initializing topic 'PQ/rt3.dc1--topic1' partition 2. Step TInitInternalFieldsStep
2025-10-26T18:18:09.062624Z node 2 :PERSQUEUE INFO: bootstrapping 1 [2:7565596443116368359:4297]
2025-10-26T18:18:09.062827Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, NewState CALCULATING
2025-10-26T18:18:09.062862Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671 moved from PLANNED to CALCULATING
2025-10-26T18:18:09.062922Z node 1 :PERSQUEUE DEBUG: Initializing topic 'PQ/rt3.dc1--topic1' partition 3. Step TInitConfigStep
2025-10-26T18:18:09.062983Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 3, State: StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-26T18:18:09.063008Z node 1 :PERSQUEUE DEBUG: Initializing topic 'PQ/rt3.dc1--topic1' partition 4. Step TInitConfigStep
2025-10-26T18:18:09.063036Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 4, State: StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-26T18:18:09.063063Z node 2 :PERSQUEUE INFO: bootstrapping 2 [2:7565596443116368360:4306]
2025-10-26T18:18:09.063463Z node 1 :PERSQUEUE DEBUG: Initializing topic 'PQ/rt3.dc1--topic1' partition 3. Step TInitInternalFieldsStep
2025-10-26T18:18:09.063776Z node 1 :PERSQUEUE INFO: bootstrapping 3 [1:7565596442757344283:4318]
2025-10-26T18:18:09.064054Z node 2 :PERSQUEUE DEBUG: Initializing topic 'PQ/rt3.dc1--topic1' partition 2. Completed.
2025-10-26T18:18:09.064086Z node 2 :PERSQUEUE DEBUG: Initializing topic 'PQ/rt3.dc1--topic1' partition 1. Completed.
2025-10-26T18:18:09.064089Z node 2 :PERSQUEUE INFO: init complete for topic 'PQ/rt3.dc1--topic1' partition 2 generation 1 [2:7565596443116368360:4306]
2025-10-26T18:18:09.064117Z node 2 :PERSQUEUE INFO: init complete for topic 'PQ/rt3.dc1--topic1' partition 1 generation 1 [2:7565596443116368359:4297]
2025-10-26T18:18:09.064150Z node 2 :PERSQUEUE DEBUG: SYNC INIT topic PQ/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:18:09.064179Z node 2 :PERSQUEUE DEBUG: SYNC INIT topic PQ/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:18:09.064791Z node 1 :PERSQUEUE DEBUG: Initializing topic 'PQ/rt3.dc1--topic1' partition 3. Completed.
2025-10-26T18:18:09.064851Z node 1 :PERSQUEUE INFO: init complete for topic 'PQ/rt3.dc1--topic1' partition 3 generation 1 [1:7565596442757344283:4318]
2025-10-26T18:18:09.064881Z node 1 :PERSQUEUE DEBUG: SYNC INIT topic PQ/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:18:09.066522Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 2, State: StateIdle] Process pending events. Count 1
2025-10-26T18:18:09.066537Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 3, State: StateIdle] Process pending events. Count 1
2025-10-26T18:18:09.066533Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 1, State: StateIdle] Process pending events. Count 1
2025-10-26T18:18:09.066761Z node 1 :PERSQUEUE DEBUG: Topic 'PQ/rt3.dc1--topic1' partition 3 user consumer-2 readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:18:09.066764Z node 2 :PERSQUEUE DEBUG: Topic 'PQ/rt3.dc1--topic1' partition 2 user consumer-2 readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:18:09.066780Z node 1 :PERSQUEUE DEBUG: Topic 'PQ/rt3.dc1--topic1' partition 3 user c0nsumer readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:18:09.066771Z node 2 :PERSQUEUE DEBUG: Topic 'PQ/rt3.dc1--topic1' partition 1 user consumer-2 readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:18:09.066790Z node 1 :PERSQUEUE DEBUG: Topic 'PQ/rt3.dc1--topic1' partition 3 user consumer-1 readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:18:09.066789Z node 2 :PERSQUEUE DEBUG: Topic 'PQ/rt3.dc1--topic1' partition 2 user c0nsumer readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:18:09.066794Z node 2 :PERSQUEUE DEBUG: Topic 'PQ/rt3.dc1--topic1' partition 1 user c0nsumer readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:18:09.066798Z node 2 :PERSQUEUE DEBUG: Topic 'PQ/rt3.dc1--topic1' partition 2 user consumer-1 readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:18:09.066820Z node 2 :PERSQUEUE DEBUG: Topic 'PQ/rt3.dc1--topic1' partition 1 user consumer-1 readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:18:09.067004Z node 1 :PERSQUEUE DEBUG: Initializing topic 'PQ/rt3.dc1--topic1' partition 0. Step TInitConfigStep
2025-10-26T18:18:09.067048Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894, Partition: 0, State: StateInit] HandleOnInit TEvPQ::TEvProposePartitionConfig
2025-10-26T18:18:09.067076Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPQ::TEvProposePartitionConfigResult Step 1761502689093, TxId 281474976715671, Partition 2
2025-10-26T18:18:09.067105Z node 2 :PERSQUEUE DEBUG: [TxId: 281474976715671] Handle TEvProposePartitionConfigResult
2025-10-26T18:18:09.067129Z node 2 :PERSQUEUE DEBUG: [TxId: 281474976715671] Partition responses 1/2
2025-10-26T18:18:09.067152Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state CALCULATING
2025-10-26T18:18:09.067170Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, State CALCULATING
2025-10-26T18:18:09.067188Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671 State CALCULATING FrontTxId 281474976715671
2025-10-26T18:18:09.067212Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 1, Expected 2
2025-10-26T18:18:09.067233Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671 status has not changed
2025-10-26T18:18:09.067251Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPQ::TEvProposePartitionConfigResult Step 1761502689093, TxId 281474976715671, Partition 1
2025-10-26T18:18:09.067267Z node 2 :PERSQUEUE DEBUG: [TxId: 281474976715671] Handle TEvProposePartitionConfigResult
2025-10-26T18:18:09.067279Z node 2 :PERSQUEUE DEBUG: [TxId: 281474976715671] Partition responses 2/2
2025-10-26T18:18:09.067288Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state CALCULATING
2025-10-26T18:18:09.067298Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, State CALCULATING
2025-10-26T18:18:09.067308Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671 State CALCULATING FrontTxId 281474976715671
2025-10-26T18:18:09.067317Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 2, Expected 2
2025-10-26T18:18:09.067410Z node 1 :PERSQUEUE DEBUG: Initializing topic 'PQ/rt3.dc1--topic1' partition 0. Step TInitInternalFieldsStep
2025-10-26T18:18:09.067345Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, NewState CALCULATED
2025-10-26T18:18:09.067370Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671 moved from CALCULATING to CALCULATED
2025-10-26T18:18:09.067389Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] write key for TxId 281474976715671
2025-10-26T18:18:09.067658Z node 1 :PERSQUEUE INFO: bootstrapping 0 [1:7565596442757344288:4322]
2025-10-26T18:18:09.068092Z node 2 :PERSQUEUE DEBUG: [TxId: 281474976715671] save tx TxId: 281474976715671 State: CALCULATED MinStep: 1761502689000 MaxStep: 18446744073709551615 Step: 1761502689093 Predicate: true Kind: KIND_CONFIG TabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 1 PartitionIds: 2 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 1 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 2 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 ReadRuleGenerations: 0 ReadRuleGenerations: 0 Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565596399807669604 RawX2: 4294979629 }
2025-10-26T18:18:09.068308Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:18:09.068378Z node 1 :PERSQUEUE DEBUG: Initializing topic 'PQ/rt3.dc1--topic1' partition 0. Completed.
2025-10-26T18:18:09.068401Z node 1 :PERSQUEUE INFO: init complete for topic 'PQ/rt3.dc1--topic1' partition 0 generation 1 [1:7565596442757344288:4322]
2025-10-26T18:18:09.068418Z node 1 :PERSQUEUE DEBUG: SYNC INIT topic PQ/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:18:09.069437Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894, Partition: 0, State: StateIdle] Process pending events. Count 1
2025-10-26T18:18:09.069618Z node 1 :PERSQUEUE DEBUG: Topic 'PQ/rt3.dc1--topic1' partition 0 user consumer-2 readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:18:09.069635Z node 1 :PERSQUEUE DEBUG: Topic 'PQ/rt3.dc1--topic1' partition 0 user c0nsumer readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:18:09.069643Z node 1 :PERSQUEUE DEBUG: Topic 'PQ/rt3.dc1--topic1' partition 0 user consumer-1 readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:18:09.069839Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Handle TEvPQ::TEvProposePartitionConfigResult Step 1761502689093, TxId 281474976715671, Partition 0
2025-10-26T18:18:09.069858Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] Handle TEvProposePartitionConfigResult
2025-10-26T18:18:09.069873Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] Partition responses 1/1
2025-10-26T18:18:09.069887Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Try execute txs with state CALCULATING
2025-10-26T18:18:09.069898Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, State CALCULATING
2025-10-26T18:18:09.069912Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671 State CALCULATING FrontTxId 281474976715671
2025-10-26T18:18:09.069922Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Received 1, Expected 1
2025-10-26T18:18:09.069939Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, NewState CALCULATED
2025-10-26T18:18:09.069960Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671 moved from CALCULATING to CALCULATED
2025-10-26T18:18:09.069977Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] write key for TxId 281474976715671
2025-10-26T18:18:09.070475Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] save tx TxId: 281474976715671 State: CALCULATED MinStep: 1 MaxStep: 18446744073709551615 Step: 1761502689093 Predicate: true Kind: KIND_CONFIG TabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 0 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 ReadRuleGenerations: 0 ReadRuleGenerations: 0 Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565596399807669604 RawX2: 4294979629 }
2025-10-26T18:18:09.070591Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:18:09.071201Z node 1 :PERSQUEUE DEBUG: Initializing topic 'PQ/rt3.dc1--topic1' partition 4. Step TInitInternalFieldsStep
2025-10-26T18:18:09.071424Z node 1 :PERSQUEUE INFO: bootstrapping 4 [1:7565596442757344284:4325]
2025-10-26T18:18:09.072078Z node 1 :PERSQUEUE DEBUG: Initializing topic 'PQ/rt3.dc1--topic1' partition 4. Completed.
2025-10-26T18:18:09.072099Z node 1 :PERSQUEUE INFO: init complete for topic 'PQ/rt3.dc1--topic1' partition 4 generation 1 [1:7565596442757344284:4325]
2025-10-26T18:18:09.072115Z node 1 :PERSQUEUE DEBUG: SYNC INIT topic PQ/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:18:09.073042Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 4, State: StateIdle] Process pending events. Count 1
2025-10-26T18:18:09.073178Z node 1 :PERSQUEUE DEBUG: Topic 'PQ/rt3.dc1--topic1' partition 4 user consumer-2 readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:18:09.073194Z node 1 :PERSQUEUE DEBUG: Topic 'PQ/rt3.dc1--topic1' partition 4 user c0nsumer readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:18:09.073204Z node 1 :PERSQUEUE DEBUG: Topic 'PQ/rt3.dc1--topic1' partition 4 user consumer-1 readTimeStamp for offset 0 initiated  queuesize 0 startOffset 0 ReadingTimestamp 0 rrg 0
2025-10-26T18:18:09.073389Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPQ::TEvProposePartitionConfigResult Step 1761502689093, TxId 281474976715671, Partition 3
2025-10-26T18:18:09.073409Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] Handle TEvProposePartitionConfigResult
2025-10-26T18:18:09.073420Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] Partition responses 1/2
2025-10-26T18:18:09.073437Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state CALCULATING
2025-10-26T18:18:09.073450Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, State CALCULATING
2025-10-26T18:18:09.073462Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671 State CALCULATING FrontTxId 281474976715671
2025-10-26T18:18:09.073473Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 1, Expected 2
2025-10-26T18:18:09.073485Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671 status has not changed
2025-10-26T18:18:09.073621Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPQ::TEvProposePartitionConfigResult Step 1761502689093, TxId 281474976715671, Partition 4
2025-10-26T18:18:09.073638Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] Handle TEvProposePartitionConfigResult
2025-10-26T18:18:09.073646Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] Partition responses 2/2
2025-10-26T18:18:09.073654Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state CALCULATING
2025-10-26T18:18:09.073662Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, State CALCULATING
2025-10-26T18:18:09.073672Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671 State CALCULATING FrontTxId 281474976715671
2025-10-26T18:18:09.073679Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 2, Expected 2
2025-10-26T18:18:09.073713Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, NewState CALCULATED
2025-10-26T18:18:09.073727Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671 moved from CALCULATING to CALCULATED
2025-10-26T18:18:09.073742Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] write key for TxId 281474976715671
2025-10-26T18:18:09.074213Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] save tx TxId: 281474976715671 State: CALCULATED MinStep: 1761502689000 MaxStep: 18446744073709551615 Step: 1761502689093 Predicate: true Kind: KIND_CONFIG TabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 3 PartitionIds: 4 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 3 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 4 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 ReadRuleGenerations: 0 ReadRuleGenerations: 0 Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565596399807669604 RawX2: 4294979629 }
2025-10-26T18:18:09.074332Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:18:09.076651Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:18:09.076680Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Try execute txs with state CALCULATED
2025-10-26T18:18:09.076694Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, State CALCULATED
2025-10-26T18:18:09.076718Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671 State CALCULATED FrontTxId 281474976715671
2025-10-26T18:18:09.076737Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, NewState WAIT_RS
2025-10-26T18:18:09.076756Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671 moved from CALCULATED to WAIT_RS
2025-10-26T18:18:09.076783Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Send TEvTxProcessing::TEvReadSet to 0 receivers. Wait TEvTxProcessing::TEvReadSet from 0 senders.
2025-10-26T18:18:09.076801Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] HaveParticipantsDecision 1
2025-10-26T18:18:09.076835Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, NewState EXECUTING
2025-10-26T18:18:09.076857Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671 moved from WAIT_RS to EXECUTING
2025-10-26T18:18:09.076873Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Received 0, Expected 1
2025-10-26T18:18:09.076944Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894, Partition: 0, State: StateIdle] Handle TEvPQ::TEvTxCommit Step 1761502689093, TxId 281474976715671
2025-10-26T18:18:09.077533Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:18:09.077554Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state CALCULATED
2025-10-26T18:18:09.077566Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, State CALCULATED
2025-10-26T18:18:09.077579Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671 State CALCULATED FrontTxId 281474976715671
2025-10-26T18:18:09.077590Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, NewState WAIT_RS
2025-10-26T18:18:09.077604Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671 moved from CALCULATED to WAIT_RS
2025-10-26T18:18:09.077617Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Send TEvTxProcessing::TEvReadSet to 0 receivers. Wait TEvTxProcessing::TEvReadSet from 0 senders.
2025-10-26T18:18:09.077629Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] HaveParticipantsDecision 1
2025-10-26T18:18:09.077648Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, NewState EXECUTING
2025-10-26T18:18:09.077729Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671 moved from WAIT_RS to EXECUTING
2025-10-26T18:18:09.077743Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 0, Expected 2
2025-10-26T18:18:09.077789Z node 1 :PERSQUEUE DEBUG: CacheProxy. Passthrough write request to KV
2025-10-26T18:18:09.077922Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 3, State: StateIdle] Handle TEvPQ::TEvTxCommit Step 1761502689093, TxId 281474976715671
2025-10-26T18:18:09.078230Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 4, State: StateIdle] Handle TEvPQ::TEvTxCommit Step 1761502689093, TxId 281474976715671
2025-10-26T18:18:09.078994Z node 1 :PERSQUEUE DEBUG: CacheProxy. Passthrough write request to KV
2025-10-26T18:18:09.079088Z node 1 :PERSQUEUE DEBUG: CacheProxy. Passthrough write request to KV
2025-10-26T18:18:09.081304Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894, Partition: 0, State: StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-26T18:18:09.081542Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Handle TEvPQ::TEvTxCommitDone Step 1761502689093, TxId 281474976715671, Partition 0
2025-10-26T18:18:09.081571Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Try execute txs with state EXECUTING
2025-10-26T18:18:09.081594Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, State EXECUTING
2025-10-26T18:18:09.081619Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671 State EXECUTING FrontTxId 281474976715671
2025-10-26T18:18:09.081639Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Received 1, Expected 1
2025-10-26T18:18:09.081663Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId: 281474976715671 send TEvPersQueue::TEvProposeTransactionResult(COMPLETE)
2025-10-26T18:18:09.081727Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] complete TxId 281474976715671
2025-10-26T18:18:09.082301Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Apply new config PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 0 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 ReadRuleGenerations: 0 ReadRuleGenerations: 0 Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false }
2025-10-26T18:18:09.082381Z node 1 :PERSQUEUE NOTICE: Tablet 72075186224037894 disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-10-26T18:18:09.082484Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] delete partitions for TxId 281474976715671
2025-10-26T18:18:09.082514Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, NewState EXECUTED
2025-10-26T18:18:09.082542Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671 moved from EXECUTING to EXECUTED
2025-10-26T18:18:09.082563Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] write key for TxId 281474976715671
2025-10-26T18:18:09.083146Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] save tx TxId: 281474976715671 State: EXECUTED MinStep: 1 MaxStep: 18446744073709551615 Step: 1761502689093 Predicate: true Kind: KIND_CONFIG TabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 0 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 0 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 ReadRuleGenerations: 0 ReadRuleGenerations: 0 Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565596399807669604 RawX2: 4294979629 }
2025-10-26T18:18:09.083419Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:18:09.083989Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 3, State: StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-26T18:18:09.084273Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893, Partition: 4, State: StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-26T18:18:09.084362Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPQ::TEvTxCommitDone Step 1761502689093, TxId 281474976715671, Partition 3
2025-10-26T18:18:09.084382Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state EXECUTING
2025-10-26T18:18:09.084395Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, State EXECUTING
2025-10-26T18:18:09.084413Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671 State EXECUTING FrontTxId 281474976715671
2025-10-26T18:18:09.084425Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 1, Expected 2
2025-10-26T18:18:09.084443Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671 status has not changed
2025-10-26T18:18:09.084496Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvPQ::TEvTxCommitDone Step 1761502689093, TxId 281474976715671, Partition 4
2025-10-26T18:18:09.084517Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state EXECUTING
2025-10-26T18:18:09.084530Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, State EXECUTING
2025-10-26T18:18:09.084539Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671 State EXECUTING FrontTxId 281474976715671
2025-10-26T18:18:09.084546Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Received 2, Expected 2
2025-10-26T18:18:09.084561Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId: 281474976715671 send TEvPersQueue::TEvProposeTransactionResult(COMPLETE)
2025-10-26T18:18:09.084582Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] complete TxId 281474976715671
2025-10-26T18:18:09.085028Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Apply new config PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 3 PartitionIds: 4 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 3 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 4 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 ReadRuleGenerations: 0 ReadRuleGenerations: 0 Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false }
2025-10-26T18:18:09.085086Z node 1 :PERSQUEUE NOTICE: Tablet 72075186224037893 disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-10-26T18:18:09.085164Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] delete partitions for TxId 281474976715671
2025-10-26T18:18:09.085183Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, NewState EXECUTED
2025-10-26T18:18:09.085198Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671 moved from EXECUTING to EXECUTED
2025-10-26T18:18:09.085216Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] write key for TxId 281474976715671
2025-10-26T18:18:09.085714Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] save tx TxId: 281474976715671 State: EXECUTED MinStep: 1761502689000 MaxStep: 18446744073709551615 Step: 1761502689093 Predicate: true Kind: KIND_CONFIG TabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 3 PartitionIds: 4 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 3 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 4 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 ReadRuleGenerations: 0 ReadRuleGenerations: 0 Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565596399807669604 RawX2: 4294979629 }
2025-10-26T18:18:09.085888Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:18:09.087501Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:18:09.087528Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Try execute txs with state EXECUTED
2025-10-26T18:18:09.087541Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, State EXECUTED
2025-10-26T18:18:09.087555Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671 State EXECUTED FrontTxId 281474976715671
2025-10-26T18:18:09.087572Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TPersQueue::SendEvReadSetAckToSenders
2025-10-26T18:18:09.087600Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, NewState WAIT_RS_ACKS
2025-10-26T18:18:09.087624Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671 moved from EXECUTED to WAIT_RS_ACKS
2025-10-26T18:18:09.087652Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] PredicateAcks: 0/0
2025-10-26T18:18:09.087668Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] HaveAllRecipientsReceive 1, AllSupportivePartitionsHaveBeenDeleted 1
2025-10-26T18:18:09.087689Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] PredicateAcks: 0/0
2025-10-26T18:18:09.087711Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] add an TxId 281474976715671 to the list for deletion
2025-10-26T18:18:09.087742Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, NewState DELETING
2025-10-26T18:18:09.087769Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] delete key for TxId 281474976715671
2025-10-26T18:18:09.087856Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:18:09.088342Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:18:09.088361Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state EXECUTED
2025-10-26T18:18:09.088377Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, State EXECUTED
2025-10-26T18:18:09.088394Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671 State EXECUTED FrontTxId 281474976715671
2025-10-26T18:18:09.088407Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TPersQueue::SendEvReadSetAckToSenders
2025-10-26T18:18:09.088420Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, NewState WAIT_RS_ACKS
2025-10-26T18:18:09.088435Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671 moved from EXECUTED to WAIT_RS_ACKS
2025-10-26T18:18:09.088456Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] PredicateAcks: 0/0
2025-10-26T18:18:09.088463Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] HaveAllRecipientsReceive 1, AllSupportivePartitionsHaveBeenDeleted 1
2025-10-26T18:18:09.088474Z node 1 :PERSQUEUE DEBUG: [TxId: 281474976715671] PredicateAcks: 0/0
2025-10-26T18:18:09.088490Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] add an TxId 281474976715671 to the list for deletion
2025-10-26T18:18:09.088505Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, NewState DELETING
2025-10-26T18:18:09.088519Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] delete key for TxId 281474976715671
2025-10-26T18:18:09.088551Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:18:09.089941Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ExecuteState, TraceId: 01k8gvvxpc6k0rmhnn1qg95738, ExecutePhyTx, tx: 0x000060C000838CD8 literal: 1 commit: 0 txCtx.DeferredEffects.size(): 0
2025-10-26T18:18:09.090019Z node 1 :KQP_EXECUTER DEBUG: ActorId: [0:0:0] TxId: 0. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Begin literal execution. Operation timeout: 299.883188s, cancelAfter: (empty maybe)
2025-10-26T18:18:09.090050Z node 1 :KQP_EXECUTER DEBUG: ActorId: [0:0:0] TxId: 0. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Begin literal execution, txs: 1
2025-10-26T18:18:09.090089Z node 1 :KQP_EXECUTER DEBUG: StageInfo: StageId #[0,0], InputsCount: 0, OutputsCount: 1
2025-10-26T18:18:09.090102Z node 1 :KQP_EXECUTER DEBUG: StageInfo: StageId #[0,1], InputsCount: 0, OutputsCount: 1
2025-10-26T18:18:09.090127Z node 1 :KQP_EXECUTER DEBUG: ActorId: [0:0:0] TxId: 0. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Stage [0,0] AST: (
(declare $version (DataType 'Int64))
(return (lambda '() (ToStream (Just (AsList (AsStruct '('"name" (Just (Utf8 '"Topics"))) '('"version" (Just $version))))))))
)
2025-10-26T18:18:09.090169Z node 1 :KQP_EXECUTER DEBUG: ActorId: [0:0:0] TxId: 0. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Stage [0,1] AST: (
(declare $cluster (DataType 'Utf8))
(declare $path (DataType 'Utf8))
(return (lambda '() (block '(
  (let $1 (DataType 'Utf8))
  (return (ToStream (Just (AsList (AsStruct '('"dc" (Just $cluster)) '('"path" (Just $path)))))))
))))
)
2025-10-26T18:18:09.090210Z node 1 :KQP_EXECUTER DEBUG: Create result channelId: 1 from task: 1 with index: 0
2025-10-26T18:18:09.090224Z node 1 :KQP_EXECUTER DEBUG: Create result channelId: 2 from task: 2 with index: 0
2025-10-26T18:18:09.091797Z node 1 :KQP_EXECUTER DEBUG: ActorId: [0:0:0] TxId: 0. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Execution is complete, results: 2
2025-10-26T18:18:09.091872Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ExecuteState, TraceId: 01k8gvvxpc6k0rmhnn1qg95738, TEvTxResponse, CurrentTx: 1/2 response.status: SUCCESS
2025-10-26T18:18:09.091985Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ExecuteState, TraceId: 01k8gvvxpc6k0rmhnn1qg95738, ExecutePhyTx, tx: 0x0000000000000000 literal: 0 commit: 1 txCtx.DeferredEffects.size(): 1
2025-10-26T18:18:09.092017Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ExecuteState, TraceId: 01k8gvvxpc6k0rmhnn1qg95738, TExecPhysicalRequest, add DeferredEffect to Transaction, current Transactions.size(): 1
2025-10-26T18:18:09.092059Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ExecuteState, TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Sending to Executer TraceId: 0 8
2025-10-26T18:18:09.092068Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:18:09.092093Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] Try execute txs with state DELETING
2025-10-26T18:18:09.092115Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] TxId 281474976715671, State DELETING
2025-10-26T18:18:09.092139Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037894] delete TxId 281474976715671
2025-10-26T18:18:09.092167Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ExecuteState, TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Created new KQP executer: [1:7565596442757344402:4323] isRollback: 0
2025-10-26T18:18:09.092288Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Executing physical tx, type: 2, stages: 2
2025-10-26T18:18:09.092363Z node 1 :KQP_EXECUTER DEBUG: StageInfo: StageId #[0,0], InputsCount: 0, OutputsCount: 1
2025-10-26T18:18:09.092396Z node 1 :KQP_EXECUTER DEBUG: StageInfo: StageId #[0,1], InputsCount: 0, OutputsCount: 1
2025-10-26T18:18:09.092474Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:18:09.092489Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] Try execute txs with state DELETING
2025-10-26T18:18:09.092500Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] TxId 281474976715671, State DELETING
2025-10-26T18:18:09.092514Z node 1 :PERSQUEUE DEBUG: [PQ: 72075186224037893] delete TxId 281474976715671
2025-10-26T18:18:09.092618Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Handle TEvTxProxySchemeCache::TEvResolveKeySet: self# [1:7565596399807669495:8201], request# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 ResultSet [{ TableId: [OwnerId: 72057594046644480, LocalPathId: 7] Access: 2 SyncVersion: false Status: Unknown Kind: KindUnknown PartitionsCount: 0 DomainInfo <null> From: (Utf8 : NULL, Utf8 : NULL) IncFrom: 1 To: () IncTo: 0 },{ TableId: [OwnerId: 72057594046644480, LocalPathId: 8] Access: 2 SyncVersion: false Status: Unknown Kind: KindUnknown PartitionsCount: 0 DomainInfo <null> From: (Utf8 : NULL) IncFrom: 1 To: () IncTo: 0 }] }
2025-10-26T18:18:09.092718Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TResolve: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596412692572171:8441] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 4 } Filled: 1 Status: StatusSuccess Kind: 3 TableKind: 1 Created: 1 CreateStep: 1761502683031 PathId: [OwnerId: 72057594046644480, LocalPathId: 7] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 1 }, entry# { TableId: [OwnerId: 72057594046644480, LocalPathId: 7] Access: 2 SyncVersion: false Status: Unknown Kind: KindUnknown PartitionsCount: 0 DomainInfo <null> }, props# { Cookie: 0 IsSync: false Partial: 0 }
2025-10-26T18:18:09.092791Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TResolve: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596412692572172:8319] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 18 } Filled: 1 Status: StatusSuccess Kind: 3 TableKind: 1 Created: 1 CreateStep: 1761502683122 PathId: [OwnerId: 72057594046644480, LocalPathId: 8] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 1 }, entry# { TableId: [OwnerId: 72057594046644480, LocalPathId: 8] Access: 2 SyncVersion: false Status: Unknown Kind: KindUnknown PartitionsCount: 0 DomainInfo <null> }, props# { Cookie: 0 IsSync: false Partial: 0 }
2025-10-26T18:18:09.093102Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Send result: self# [1:7565596442757344408:8412], recipient# [1:7565596442757344404:4323], result# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 ResultSet [{ TableId: [OwnerId: 72057594046644480, LocalPathId: 7] Access: 2 SyncVersion: false Status: OkData Kind: KindRegularTable PartitionsCount: 1 DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } From: (Utf8 : NULL, Utf8 : NULL) IncFrom: 1 To: () IncTo: 0 },{ TableId: [OwnerId: 72057594046644480, LocalPathId: 8] Access: 2 SyncVersion: false Status: OkData Kind: KindRegularTable PartitionsCount: 1 DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } From: (Utf8 : NULL) IncFrom: 1 To: () IncTo: 0 }] }
2025-10-26T18:18:09.093203Z node 1 :KQP_EXECUTER DEBUG: TxId: 281474976715672. Resolved key sets: 2
2025-10-26T18:18:09.093365Z node 1 :KQP_EXECUTER DEBUG: TxId: 281474976715672. Resolved key: { TableId: [OwnerId: 72057594046644480, LocalPathId: 7] Access: 2 SyncVersion: false Status: OkData Kind: KindRegularTable PartitionsCount: 1 DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } From: (Utf8 : NULL, Utf8 : NULL) IncFrom: 1 To: () IncTo: 0 }
2025-10-26T18:18:09.093432Z node 1 :KQP_EXECUTER DEBUG: TxId: 281474976715672. Resolved key: { TableId: [OwnerId: 72057594046644480, LocalPathId: 8] Access: 2 SyncVersion: false Status: OkData Kind: KindRegularTable PartitionsCount: 1 DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } From: (Utf8 : NULL) IncFrom: 1 To: () IncTo: 0 }
2025-10-26T18:18:09.093492Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Stage [0,0] AST: (
(declare %kqp%tx_result_binding_0_1 (ListType (StructType '('"dc" (OptionalType (DataType 'Utf8))) '('"path" (OptionalType (DataType 'Utf8))))))
(return (lambda '() (block '(
  (let $1 (KqpTable '"/Root/PQ/Config/V2/Topics" '"72057594046644480:7" '"" '1))
  (let $2 (OptionalType (DataType 'Utf8)))
  (return (KqpEffects (KqpUpsertRows $1 (Iterator %kqp%tx_result_binding_0_1) '('"dc" '"path") '('('"Mode" '"upsert")))))
))))
)
2025-10-26T18:18:09.093667Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Stage [0,0] will be executed on 1 shards.
2025-10-26T18:18:09.093753Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. ActorState: WaitResolveState, stage: [0,0] create datashard task: 1, shard: 72075186224037890, meta: TTaskMeta{ ShardId: 72075186224037890, Reads: { none }, Writes: { ranges: TShardKeyRanges{ (Utf8 : /Root/PQ/rt3.dc1/topic1, Utf8 : unknown), } } }
2025-10-26T18:18:09.093813Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:18:09.093775Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Stage [0,1] AST: (
(declare %kqp%tx_result_binding_0_0 (ListType (StructType '('"name" (OptionalType (DataType 'Utf8))) '('"version" (OptionalType (DataType 'Int64))))))
(return (lambda '() (block '(
  (let $1 (KqpTable '"/Root/PQ/Config/V2/Versions" '"72057594046644480:8" '"" '1))
  (return (KqpEffects (KqpUpsertRows $1 (Iterator %kqp%tx_result_binding_0_0) '('"name" '"version") '('('"Mode" '"upsert")))))
))))
)
2025-10-26T18:18:09.093861Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Stage [0,1] will be executed on 1 shards.
2025-10-26T18:18:09.093851Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state CALCULATED
2025-10-26T18:18:09.093903Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. ActorState: WaitResolveState, stage: [0,1] create datashard task: 2, shard: 72075186224037891, meta: TTaskMeta{ ShardId: 72075186224037891, Reads: { none }, Writes: { ranges: TShardKeyRanges{ (Utf8 : Topics), } } }
2025-10-26T18:18:09.093865Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, State CALCULATED
2025-10-26T18:18:09.093912Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671 State CALCULATED FrontTxId 281474976715671
2025-10-26T18:18:09.093930Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, NewState WAIT_RS
2025-10-26T18:18:09.093974Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671 moved from CALCULATED to WAIT_RS
2025-10-26T18:18:09.093995Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Send TEvTxProcessing::TEvReadSet to 0 receivers. Wait TEvTxProcessing::TEvReadSet from 0 senders.
2025-10-26T18:18:09.094007Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] HaveParticipantsDecision 1
2025-10-26T18:18:09.094039Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, NewState EXECUTING
2025-10-26T18:18:09.094052Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671 moved from WAIT_RS to EXECUTING
2025-10-26T18:18:09.094068Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 0, Expected 2
2025-10-26T18:18:09.094106Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 2, State: StateIdle] Handle TEvPQ::TEvTxCommit Step 1761502689093, TxId 281474976715671
2025-10-26T18:18:09.094109Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 1, State: StateIdle] Handle TEvPQ::TEvTxCommit Step 1761502689093, TxId 281474976715671
2025-10-26T18:18:09.094446Z node 1 :KQP_EXECUTER ERROR: TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-10-26T18:18:09.094489Z node 1 :KQP_EXECUTER DEBUG: TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Total tasks: 0, readonly: true, 0 scan tasks on 0 nodes, pool: Data, localComputeTasks: 1, snapshot: {0, 0}
2025-10-26T18:18:09.094584Z node 2 :PERSQUEUE DEBUG: CacheProxy. Passthrough write request to KV
2025-10-26T18:18:09.094725Z node 2 :PERSQUEUE DEBUG: CacheProxy. Passthrough write request to KV
2025-10-26T18:18:09.097352Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 1, State: StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-26T18:18:09.097372Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892, Partition: 2, State: StateIdle] TPartition::HandleWriteResponse writeNewSize# 0 WriteNewSizeFromSupportivePartitions# 0
2025-10-26T18:18:09.097494Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPQ::TEvTxCommitDone Step 1761502689093, TxId 281474976715671, Partition 1
2025-10-26T18:18:09.097519Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state EXECUTING
2025-10-26T18:18:09.097533Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, State EXECUTING
2025-10-26T18:18:09.097548Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671 State EXECUTING FrontTxId 281474976715671
2025-10-26T18:18:09.097559Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 1, Expected 2
2025-10-26T18:18:09.097573Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671 status has not changed
2025-10-26T18:18:09.097588Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvPQ::TEvTxCommitDone Step 1761502689093, TxId 281474976715671, Partition 2
2025-10-26T18:18:09.097597Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state EXECUTING
2025-10-26T18:18:09.097605Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, State EXECUTING
2025-10-26T18:18:09.097615Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671 State EXECUTING FrontTxId 281474976715671
2025-10-26T18:18:09.097622Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Received 2, Expected 2
2025-10-26T18:18:09.097639Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId: 281474976715671 send TEvPersQueue::TEvProposeTransactionResult(COMPLETE)
2025-10-26T18:18:09.097675Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] complete TxId 281474976715671
2025-10-26T18:18:09.098166Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Apply new config PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 1 PartitionIds: 2 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 1 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 2 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 ReadRuleGenerations: 0 ReadRuleGenerations: 0 Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false }
2025-10-26T18:18:09.098235Z node 2 :PERSQUEUE NOTICE: Tablet 72075186224037892 disable metering: reason# billing is not enabled in BillingMeteringConfig
2025-10-26T18:18:09.098310Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] delete partitions for TxId 281474976715671
2025-10-26T18:18:09.098329Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, NewState EXECUTED
2025-10-26T18:18:09.098349Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671 moved from EXECUTING to EXECUTED
2025-10-26T18:18:09.098365Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] write key for TxId 281474976715671
2025-10-26T18:18:09.098873Z node 2 :PERSQUEUE DEBUG: [TxId: 281474976715671] save tx TxId: 281474976715671 State: EXECUTED MinStep: 1761502689000 MaxStep: 18446744073709551615 Step: 1761502689093 Predicate: true Kind: KIND_CONFIG TabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 TotalPartitions: 5 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } PartitionIds: 1 PartitionIds: 2 TopicName: "rt3.dc1--topic1" Version: 0 RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 TopicPath: "/Root/PQ/rt3.dc1--topic1" YcCloudId: "" YcFolderId: "" YdbDatabaseId: "" YdbDatabasePath: "/Root" Partitions { PartitionId: 1 Status: Active CreateVersion: 1 TabletId: 0 } Partitions { PartitionId: 2 Status: Active CreateVersion: 1 TabletId: 0 } ReadRuleGenerations: 0 ReadRuleGenerations: 0 ReadRuleGenerations: 0 Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 Generation: 0 Important: false } } BootstrapConfig { } SourceActor { RawX1: 7565596399807669604 RawX2: 4294979629 }
2025-10-26T18:18:09.099070Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:18:09.101124Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. datashard task: 1, proto: Id: 1 Executer { ActorId { RawX1: 7565596442757344402 RawX2: 4503603922342115 } } Program { RuntimeVersion: 100000 Raw: "\037\002\022KqpEffect\005\205\006\213\000\205\002\206\205\004\207\203\001H\207\203\001H\010dc\020pathh%kqp%tx_result_binding_0_1\204\214\002\030Inputs(Parameters\034Program\013?\000)\251\000?\016\014Arg\000\002)\211\002?\022\204\214\002(KqpEffects\000)\211\010?\036\213\010\203\010\203\010\203\005@\203\010\204?\n\210\203\004\203\004\203\0144KqpUpsertRows\000\013?*\003?\"\177\000\001\205\000\000\000\000\001\003?$\016\003?&\000\003?(\002\017)\211\002?,?\014 Iterator\000)\211\004?\014?\016\203\004\030Member\000?\032\003?D\000\002\004\000\006\010\000?2\003?4\000\r\010\000\n\001/" Settings { LevelDataPrediction: 2 InputDataPrediction: 1 OutputDataPrediction: 1 NodesCount: 52 } } Parameters { key: "%kqp%tx_result_binding_0_1" value { TransportVersion: 20000 Raw: "\"\000\000\000\000\002\016unknown./Root/PQ/rt3.dc1/topic1" Rows: 1 } } Outputs { Effects { } } Meta { [type.googleapis.com/NKikimrTxDataShard.TKqpTransaction.TDataTaskMeta] { Table { TableId { OwnerId: 72057594046644480 TableId: 7 } TablePath: "/Root/PQ/Config/V2/Topics" SchemaVersion: 1 SysViewInfo: "" TableKind: 1 } Writes { Range { Ranges { KeyPoints: "\002\000\027\000\000\000/Root/PQ/rt3.dc1/topic1\007\000\000\000unknown" } } Columns { Column { Id: 1 Name: "path" Type: 4608 } MaxValueSizeBytes: 25 } Columns { Column { Id: 2 Name: "dc" Type: 4608 } MaxValueSizeBytes: 9 } } } } UseLlvm: false RequestContext { key: "CurrentExecutionId" value: "" } RequestContext { key: "CustomerSuppliedId" value: "" } RequestContext { key: "Database" value: "" } RequestContext { key: "DatabaseId" value: "/Root" } RequestContext { key: "PoolId" value: "" } RequestContext { key: "SessionId" value: "ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==" } RequestContext { key: "TraceId" value: "01k8gvvxpc6k0rmhnn1qg95738" } EnableSpilling: false
2025-10-26T18:18:09.101323Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. State: WaitResolveState, Executing KQP transaction on shard: 72075186224037890, tasks: [1], lockTxId: (empty maybe), locks: SendingShards: 72075186224037890 SendingShards: 72075186224037891 ReceivingShards: 72075186224037890 ReceivingShards: 72075186224037891 Op: Commit
2025-10-26T18:18:09.101417Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: HandleNotify: self# [1:7565596399807669495:8201], notify# NKikimr::TSchemeBoardEvents::TEvNotifyUpdate { Path: /Root/PQ PathId: [OwnerId: 72057594046644480, LocalPathId: 2] DescribeSchemeResult: Status: StatusSuccess Path: "/Root/PQ" PathDescription { Self { Name: "PQ" PathId: 2 SchemeshardId: 72057594046644480 PathType: EPathTypeDir CreateFinished: true CreateTxId: 281474976715658 CreateStep: 1761502680651 ParentPathId: 1 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "" EffectiveACL: "" PathVersion: 9 PathSubType: EPathSubTypeEmpty Version { GeneralVersion: 9 ACLVersion: 0 EffectiveACLVersion: 0 UserAttrsVersion: 1 ChildrenVersion: 8 } } Children { Name: "Config" PathId: 4 SchemeshardId: 72057594046644480 PathType: EPathTypeDir CreateFinished: true CreateTxId: 281474976715660 CreateStep: 1761502680819 ParentPathId: 2 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "" } Children { Name: "SourceIdMeta2" PathId: 3 SchemeshardId: 72057594046644480 PathType: EPathTypeTable CreateFinished: true CreateTxId: 281474976715659 CreateStep: 1761502680770 ParentPathId: 2 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "" } Children { Name: "rt3.dc1--topic1" PathId: 9 SchemeshardId: 72057594046644480 PathType: EPathTypePersQueueGroup CreateFinished: true CreateTxId: 281474976715671 CreateStep: 1761502689093 ParentPathId: 2 PathState: EPathStateCreate Owner: "root@builtin" BalancerTabletID: 72075186224037895 } 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: 8 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: 5 PQPartitionsLimit: 1000000 } } PathId: 2 PathOwnerId: 72057594046644480 }
2025-10-26T18:18:09.101441Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. ExecuteDatashardTransaction traceId.verbosity: 0
2025-10-26T18:18:09.101735Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: ResolveCacheItem: self# [1:7565596399807669495:8201], notify# NKikimr::TSchemeBoardEvents::TEvNotifyUpdate { Path: /Root/PQ PathId: [OwnerId: 72057594046644480, LocalPathId: 2] DescribeSchemeResult: Status: StatusSuccess Path: "/Root/PQ" PathDescription { Self { Name: "PQ" PathId: 2 SchemeshardId: 72057594046644480 PathType: EPathTypeDir CreateFinished: true CreateTxId: 281474976715658 CreateStep: 1761502680651 ParentPathId: 1 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "" EffectiveACL: "" PathVersion: 9 PathSubType: EPathSubTypeEmpty Version { GeneralVersion: 9 ACLVersion: 0 EffectiveACLVersion: 0 UserAttrsVersion: 1 ChildrenVersion: 8 } } Children { Name: "Config" PathId: 4 SchemeshardId: 72057594046644480 PathType: EPathTypeDir CreateFinished: true CreateTxId: 281474976715660 CreateStep: 1761502680819 ParentPathId: 2 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "" } Children { Name: "SourceIdMeta2" PathId: 3 SchemeshardId: 72057594046644480 PathType: EPathTypeTable CreateFinished: true CreateTxId: 281474976715659 CreateStep: 1761502680770 ParentPathId: 2 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "" } Children { Name: "rt3.dc1--topic1" PathId: 9 SchemeshardId: 72057594046644480 PathType: EPathTypePersQueueGroup CreateFinished: true CreateTxId: 281474976715671 CreateStep: 1761502689093 ParentPathId: 2 PathState: EPathStateCreate Owner: "root@builtin" BalancerTabletID: 72075186224037895 } 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: 8 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: 5 PQPartitionsLimit: 1000000 } } PathId: 2 PathOwnerId: 72057594046644480 }, by path# { Subscriber: { Subscriber: [1:7565596404102637352:8392] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 10 } Filled: 1 Status: StatusSuccess Kind: 2 TableKind: 0 Created: 1 CreateStep: 1761502680651 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, by pathId# { Subscriber: { Subscriber: [1:7565596404102637352:8392] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 10 } Filled: 1 Status: StatusSuccess Kind: 2 TableKind: 0 Created: 1 CreateStep: 1761502680651 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }
2025-10-26T18:18:09.102175Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. datashard task: 2, proto: Id: 2 Executer { ActorId { RawX1: 7565596442757344402 RawX2: 4503603922342115 } } Program { RuntimeVersion: 100000 Raw: "\037\002\022KqpEffect\005\205\006\213\000\205\002\206\205\004\207\203\001H\207\203\006\020name\034versionh%kqp%tx_result_binding_0_0\204\214\002\030Inputs(Parameters\034Program\013?\000)\251\000?\016\014Arg\000\002)\211\002?\022\204\214\002(KqpEffects\000)\211\010?\036\213\010\203\010\203\010\203\005@\203\010\204?\n\210\203\004\203\004\203\0144KqpUpsertRows\000\013?*\003?\"\177\000\001\205\000\000\000\000\001\003?$\020\003?&\000\003?(\002\017)\211\002?,?\014 Iterator\000)\211\004?\014?\016\203\004\030Member\000?\032\003?D\000\002\004\000\006\010\002?2\003\203\004\004\003\203\004\002\003\003?4\000\r\010\000\n\001/" Settings { LevelDataPrediction: 2 InputDataPrediction: 1 OutputDataPrediction: 1 NodesCount: 58 } } Parameters { key: "%kqp%tx_result_binding_0_0" value { TransportVersion: 20000 Raw: "\n\000\000\000\000\002\014Topics\004" Rows: 1 } } Outputs { Effects { } } Meta { [type.googleapis.com/NKikimrTxDataShard.TKqpTransaction.TDataTaskMeta] { Table { TableId { OwnerId: 72057594046644480 TableId: 8 } TablePath: "/Root/PQ/Config/V2/Versions" SchemaVersion: 1 SysViewInfo: "" TableKind: 1 } Writes { Range { Ranges { KeyPoints: "\001\000\006\000\000\000Topics" } } Columns { Column { Id: 1 Name: "name" Type: 4608 } MaxValueSizeBytes: 8 } Columns { Column { Id: 2 Name: "version" Type: 3 } MaxValueSizeBytes: 8 } } } } StageId: 1 UseLlvm: false RequestContext { key: "CurrentExecutionId" value: "" } RequestContext { key: "CustomerSuppliedId" value: "" } RequestContext { key: "Database" value: "" } RequestContext { key: "DatabaseId" value: "/Root" } RequestContext { key: "PoolId" value: "" } RequestContext { key: "SessionId" value: "ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==" } RequestContext { key: "TraceId" value: "01k8gvvxpc6k0rmhnn1qg95738" } EnableSpilling: false
2025-10-26T18:18:09.102332Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. State: WaitResolveState, Executing KQP transaction on shard: 72075186224037891, tasks: [2], lockTxId: (empty maybe), locks: SendingShards: 72075186224037890 SendingShards: 72075186224037891 ReceivingShards: 72075186224037890 ReceivingShards: 72075186224037891 Op: Commit
2025-10-26T18:18:09.102444Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. ExecuteDatashardTransaction traceId.verbosity: 0
2025-10-26T18:18:09.102504Z node 1 :KQP_EXECUTER INFO: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Total tasks: 2, readonly: 0, datashardTxs: 2, evWriteTxs: 0, topicTxs: 0, volatile: 1, immediate: 0, pending compute tasks0, useFollowers: 0
2025-10-26T18:18:09.102577Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. ActorState: WaitResolveState, datashard 72075186224037890 not finished yet: Preparing
2025-10-26T18:18:09.102597Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. ActorState: WaitResolveState, datashard 72075186224037891 not finished yet: Preparing
2025-10-26T18:18:09.102635Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. ActorState: WaitResolveState, waiting for 0 compute actor(s) and 2 datashard(s): DS 72075186224037890 (Preparing), DS 72075186224037891 (Preparing), 
2025-10-26T18:18:09.102677Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. ActorState: WaitResolveState, not immediate tx, become PrepareState
2025-10-26T18:18:09.103105Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:18:09.103135Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state EXECUTED
2025-10-26T18:18:09.103150Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, State EXECUTED
2025-10-26T18:18:09.103173Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671 State EXECUTED FrontTxId 281474976715671
2025-10-26T18:18:09.103186Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TPersQueue::SendEvReadSetAckToSenders
2025-10-26T18:18:09.103206Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, NewState WAIT_RS_ACKS
2025-10-26T18:18:09.103221Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671 moved from EXECUTED to WAIT_RS_ACKS
2025-10-26T18:18:09.103237Z node 2 :PERSQUEUE DEBUG: [TxId: 281474976715671] PredicateAcks: 0/0
2025-10-26T18:18:09.103247Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] HaveAllRecipientsReceive 1, AllSupportivePartitionsHaveBeenDeleted 1
2025-10-26T18:18:09.103259Z node 2 :PERSQUEUE DEBUG: [TxId: 281474976715671] PredicateAcks: 0/0
2025-10-26T18:18:09.103273Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] add an TxId 281474976715671 to the list for deletion
2025-10-26T18:18:09.103286Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, NewState DELETING
2025-10-26T18:18:09.103308Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] delete key for TxId 281474976715671
2025-10-26T18:18:09.103398Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Send TEvKeyValue::TEvRequest (WRITE_TX_COOKIE)
2025-10-26T18:18:09.104779Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Got propose result, shard: 72075186224037891, status: PREPARED, error: 
2025-10-26T18:18:09.104819Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Not all shards are prepared, waiting...
2025-10-26T18:18:09.106623Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Handle TEvKeyValue::TEvResponse (WRITE_TX_COOKIE)
2025-10-26T18:18:09.106660Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] Try execute txs with state DELETING
2025-10-26T18:18:09.106673Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] TxId 281474976715671, State DELETING
2025-10-26T18:18:09.106694Z node 2 :PERSQUEUE DEBUG: [PQ: 72075186224037892] delete TxId 281474976715671
2025-10-26T18:18:09.106701Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Got propose result, shard: 72075186224037890, status: PREPARED, error: 
2025-10-26T18:18:09.106739Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. All shards prepared, become ExecuteState.
2025-10-26T18:18:09.106908Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Got transaction status, status: 16
2025-10-26T18:18:09.107018Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Got transaction status, status: 17
2025-10-26T18:18:09.110271Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Got propose result, shard: 72075186224037891, status: COMPLETE, error: 
2025-10-26T18:18:09.110326Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. ActorState: ExecuteState, datashard 72075186224037890 not finished yet: Executing
2025-10-26T18:18:09.110365Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. ActorState: ExecuteState, waiting for 0 compute actor(s) and 1 datashard(s): DS 72075186224037890 (Executing), 
2025-10-26T18:18:09.110440Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Got propose result, shard: 72075186224037890, status: COMPLETE, error: 
2025-10-26T18:18:09.110554Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. terminate execution.
2025-10-26T18:18:09.110593Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344402:4323] TxId: 281474976715672. Ctx: { TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Resource usage for last stat interval: ComputeTime: 0.000000s ReadRows: 0 ReadBytes: 0 ru: 1 rate limiter was not found force flag: 1
2025-10-26T18:18:09.110645Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ExecuteState, TraceId: 01k8gvvxpc6k0rmhnn1qg95738, TEvTxResponse, CurrentTx: 2/2 response.status: SUCCESS
2025-10-26T18:18:09.110829Z node 1 :KQP_SESSION INFO: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ExecuteState, TraceId: 01k8gvvxpc6k0rmhnn1qg95738, txInfo  Status: Committed Kind: WriteOnly TotalDuration: 21.058 ServerDuration: 20.882 QueriesCount: 2
2025-10-26T18:18:09.110885Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ExecuteState, TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Create QueryResponse for action: QUERY_ACTION_EXECUTE with SUCCESS status
2025-10-26T18:18:09.111163Z node 1 :KQP_SESSION INFO: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ExecuteState, TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Cleanup start, isFinal: 0 CleanupCtx: 0 TransactionsToBeAborted.size(): 0 WorkerId: [0:0:0] WorkloadServiceCleanup: 0
2025-10-26T18:18:09.111202Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ExecuteState, TraceId: 01k8gvvxpc6k0rmhnn1qg95738, EndCleanup, isFinal: 0
2025-10-26T18:18:09.111290Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ExecuteState, TraceId: 01k8gvvxpc6k0rmhnn1qg95738, Sent query response back to proxy, proxyRequestId: 15, proxyId: [1:7565596399807669470:12300]
2025-10-26T18:18:09.111314Z node 1 :KQP_PROXY DEBUG: TraceId: "01k8gvvxpc6k0rmhnn1qg95738", Forwarded response to sender actor, requestId: 15, sender: [1:7565596438462376744:8516], selfId: [1:7565596399807669470:12300], source: [1:7565596438462376737:4323]
2025-10-26T18:18:09.118840Z node 1 :KQP_SESSION INFO: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ReadyState, Session closed due to explicit close event
2025-10-26T18:18:09.118901Z node 1 :KQP_SESSION INFO: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ReadyState, Cleanup start, isFinal: 1 CleanupCtx: 0 TransactionsToBeAborted.size(): 0 WorkerId: [0:0:0] WorkloadServiceCleanup: 0
2025-10-26T18:18:09.118924Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: ReadyState, EndCleanup, isFinal: 1
2025-10-26T18:18:09.118954Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: unknown state, Cleanup temp tables: 0
2025-10-26T18:18:09.119042Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, ActorId: [1:7565596438462376737:4323], ActorState: unknown state, Session actor destroyed
2025-10-26T18:18:09.119118Z node 1 :KQP_PROXY DEBUG: Session closed, sessionId: ydb://session/3?node_id=1&id=ODc0MjU0ZmYtNWQ0ZDZhZi1kN2RlN2M3My1lNWRiOTk2Yg==, workerId: [1:7565596438462376737:4323], local sessions count: 0
===Query complete
Create topic result: 1 
2025-10-26T18:18:09.120347Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Handle TEvTxProxySchemeCache::TEvNavigateKeySet: self# [1:7565596399807669495:8201], request# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root/PQ/rt3.dc1--topic1 TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpPath RedirectRequired: true ShowPrivatePath: true SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }] }
2025-10-26T18:18:09.123851Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: HandleNotify: self# [1:7565596399807669495:8201], notify# NKikimr::TSchemeBoardEvents::TEvNotifyUpdate { Path: /Root/PQ/rt3.dc1--topic1 PathId: [OwnerId: 72057594046644480, LocalPathId: 9] DescribeSchemeResult: Status: StatusSuccess Path: "/Root/PQ/rt3.dc1--topic1" PathDescription { Self { Name: "rt3.dc1--topic1" PathId: 9 SchemeshardId: 72057594046644480 PathType: EPathTypePersQueueGroup CreateFinished: true CreateTxId: 281474976715671 CreateStep: 1761502689093 ParentPathId: 2 PathState: EPathStateCreate Owner: "root@builtin" ACL: "" EffectiveACL: "" PathVersion: 2 PathSubType: EPathSubTypeEmpty Version { GeneralVersion: 2 ACLVersion: 0 EffectiveACLVersion: 0 UserAttrsVersion: 1 ChildrenVersion: 0 PQVersion: 1 } BalancerTabletID: 72075186224037895 } PersQueueGroup { Name: "rt3.dc1--topic1" PathId: 9 TotalGroupCount: 5 PartitionPerTablet: 2 PQTabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 YdbDatabasePath: "/Root" Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } } Partitions { PartitionId: 0 TabletId: 72075186224037894 Status: Active } Partitions { PartitionId: 1 TabletId: 72075186224037892 Status: Active } Partitions { PartitionId: 2 TabletId: 72075186224037892 Status: Active } Partitions { PartitionId: 3 TabletId: 72075186224037893 Status: Active } Partitions { PartitionId: 4 TabletId: 72075186224037893 Status: Active } AlterVersion: 1 BalancerTabletID: 72075186224037895 NextPartitionId: 5 } 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: 8 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: 5 PQPartitionsLimit: 1000000 } } PathId: 9 PathOwnerId: 72057594046644480 }
2025-10-26T18:18:09.124650Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: ResolveCacheItem: self# [1:7565596399807669495:8201], notify# NKikimr::TSchemeBoardEvents::TEvNotifyUpdate { Path: /Root/PQ/rt3.dc1--topic1 PathId: [OwnerId: 72057594046644480, LocalPathId: 9] DescribeSchemeResult: Status: StatusSuccess Path: "/Root/PQ/rt3.dc1--topic1" PathDescription { Self { Name: "rt3.dc1--topic1" PathId: 9 SchemeshardId: 72057594046644480 PathType: EPathTypePersQueueGroup CreateFinished: true CreateTxId: 281474976715671 CreateStep: 1761502689093 ParentPathId: 2 PathState: EPathStateCreate Owner: "root@builtin" ACL: "" EffectiveACL: "" PathVersion: 2 PathSubType: EPathSubTypeEmpty Version { GeneralVersion: 2 ACLVersion: 0 EffectiveACLVersion: 0 UserAttrsVersion: 1 ChildrenVersion: 0 PQVersion: 1 } BalancerTabletID: 72075186224037895 } PersQueueGroup { Name: "rt3.dc1--topic1" PathId: 9 TotalGroupCount: 5 PartitionPerTablet: 2 PQTabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 YdbDatabasePath: "/Root" Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } } Partitions { PartitionId: 0 TabletId: 72075186224037894 Status: Active } Partitions { PartitionId: 1 TabletId: 72075186224037892 Status: Active } Partitions { PartitionId: 2 TabletId: 72075186224037892 Status: Active } Partitions { PartitionId: 3 TabletId: 72075186224037893 Status: Active } Partitions { PartitionId: 4 TabletId: 72075186224037893 Status: Active } AlterVersion: 1 BalancerTabletID: 72075186224037895 NextPartitionId: 5 } 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: 8 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: 5 PQPartitionsLimit: 1000000 } } PathId: 9 PathOwnerId: 72057594046644480 }, by path# { Subscriber: { Subscriber: [1:7565596442757344452:8414] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 1 } Filled: 0 Status: undefined Kind: 0 TableKind: 0 Created: 0 CreateStep: 0 PathId: <Invalid> DomainId: <Invalid> IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, by pathId# nullptr
2025-10-26T18:18:09.124838Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: HandleNotify: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ/rt3.dc1--topic1 PathId: <Invalid> Partial: 0 }
2025-10-26T18:18:09.124947Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: ResolveCacheItem: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ/rt3.dc1--topic1 PathId: <Invalid> Partial: 0 }, by path# { Subscriber: { Subscriber: [1:7565596442757344452:8414] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 1 } Filled: 1 Status: StatusSuccess Kind: 4 TableKind: 0 Created: 1 CreateStep: 1761502689093 PathId: [OwnerId: 72057594046644480, LocalPathId: 9] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, by pathId# nullptr
2025-10-26T18:18:09.125040Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TNavigate: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596442757344452:8414] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 1 } Filled: 1 Status: StatusSuccess Kind: 4 TableKind: 0 Created: 1 CreateStep: 1761502689093 PathId: [OwnerId: 72057594046644480, LocalPathId: 9] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, entry# { Path: Root/PQ/rt3.dc1--topic1 TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpPath RedirectRequired: true ShowPrivatePath: true SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }, props# { Cookie: 1 IsSync: true Partial: 0 }
2025-10-26T18:18:09.125195Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Send result: self# [1:7565596442757344459:8632], recipient# [1:7565596442757344451:8537], result# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root/PQ/rt3.dc1--topic1 TableId: [72057594046644480:9:0] RequestType: ByPath Operation: OpPath RedirectRequired: true ShowPrivatePath: true SyncVersion: true Status: Ok Kind: KindTopic DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } }] }
2025-10-26T18:18:09.125975Z node 1 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpModifyACL, opId: 281474976715673:0, at schemeshard:  72057594046644480
2025-10-26T18:18:09.130161Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: HandleNotify: self# [1:7565596399807669495:8201], notify# NKikimr::TSchemeBoardEvents::TEvNotifyUpdate { Path: /Root/PQ/rt3.dc1--topic1 PathId: [OwnerId: 72057594046644480, LocalPathId: 9] DescribeSchemeResult: Status: StatusSuccess Path: "/Root/PQ/rt3.dc1--topic1" PathDescription { Self { Name: "rt3.dc1--topic1" PathId: 9 SchemeshardId: 72057594046644480 PathType: EPathTypePersQueueGroup CreateFinished: true CreateTxId: 281474976715671 CreateStep: 1761502689093 ParentPathId: 2 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "\n\031\010\001\020\200\004\032\020x-user-x@builtin \003\n\030\010\001\020\001\032\020x-user-x@builtin \003" EffectiveACL: "\n\031\010\001\020\200\004\032\020x-user-x@builtin \003\n\030\010\001\020\001\032\020x-user-x@builtin \003" PathVersion: 3 PathSubType: EPathSubTypeEmpty Version { GeneralVersion: 3 ACLVersion: 1 EffectiveACLVersion: 1 UserAttrsVersion: 1 ChildrenVersion: 0 PQVersion: 1 } BalancerTabletID: 72075186224037895 } PersQueueGroup { Name: "rt3.dc1--topic1" PathId: 9 TotalGroupCount: 5 PartitionPerTablet: 2 PQTabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 YdbDatabasePath: "/Root" Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } } Partitions { PartitionId: 0 TabletId: 72075186224037894 Status: Active } Partitions { PartitionId: 1 TabletId: 72075186224037892 Status: Active } Partitions { PartitionId: 2 TabletId: 72075186224037892 Status: Active } Partitions { PartitionId: 3 TabletId: 72075186224037893 Status: Active } Partitions { PartitionId: 4 TabletId: 72075186224037893 Status: Active } AlterVersion: 1 BalancerTabletID: 72075186224037895 NextPartitionId: 5 } 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: 8 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: 5 PQPartitionsLimit: 1000000 } } PathId: 9 PathOwnerId: 72057594046644480 }
2025-10-26T18:18:09.130985Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: ResolveCacheItem: self# [1:7565596399807669495:8201], notify# NKikimr::TSchemeBoardEvents::TEvNotifyUpdate { Path: /Root/PQ/rt3.dc1--topic1 PathId: [OwnerId: 72057594046644480, LocalPathId: 9] DescribeSchemeResult: Status: StatusSuccess Path: "/Root/PQ/rt3.dc1--topic1" PathDescription { Self { Name: "rt3.dc1--topic1" PathId: 9 SchemeshardId: 72057594046644480 PathType: EPathTypePersQueueGroup CreateFinished: true CreateTxId: 281474976715671 CreateStep: 1761502689093 ParentPathId: 2 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "\n\031\010\001\020\200\004\032\020x-user-x@builtin \003\n\030\010\001\020\001\032\020x-user-x@builtin \003" EffectiveACL: "\n\031\010\001\020\200\004\032\020x-user-x@builtin \003\n\030\010\001\020\001\032\020x-user-x@builtin \003" PathVersion: 3 PathSubType: EPathSubTypeEmpty Version { GeneralVersion: 3 ACLVersion: 1 EffectiveACLVersion: 1 UserAttrsVersion: 1 ChildrenVersion: 0 PQVersion: 1 } BalancerTabletID: 72075186224037895 } PersQueueGroup { Name: "rt3.dc1--topic1" PathId: 9 TotalGroupCount: 5 PartitionPerTablet: 2 PQTabletConfig { PartitionConfig { MaxCountInPartition: 2147483647 MaxSizeInPartition: 9223372036854775807 LifetimeSeconds: 64800 SourceIdLifetimeSeconds: 1382400 WriteSpeedInBytesPerSecond: 2097152 BurstSize: 2097152 ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } ExplicitChannelProfiles { PoolKind: "test" } SourceIdMaxCounts: 6000000 } RequireAuthWrite: true RequireAuthRead: true ReadRules: "c0nsumer" ReadRules: "consumer-1" ReadRules: "consumer-2" ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ReadFromTimestampsMs: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerFormatVersions: 0 ConsumerCodecs { } ConsumerCodecs { } ConsumerCodecs { } ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" ReadRuleServiceTypes: "data-streams" FormatVersion: 0 Codecs { } ReadRuleVersions: 0 ReadRuleVersions: 0 ReadRuleVersions: 0 YdbDatabasePath: "/Root" Consumers { Name: "c0nsumer" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } Consumers { Name: "consumer-1" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } Consumers { Name: "consumer-2" ReadFromTimestampsMs: 0 FormatVersion: 0 Codec { } ServiceType: "data-streams" Version: 0 } } Partitions { PartitionId: 0 TabletId: 72075186224037894 Status: Active } Partitions { PartitionId: 1 TabletId: 72075186224037892 Status: Active } Partitions { PartitionId: 2 TabletId: 72075186224037892 Status: Active } Partitions { PartitionId: 3 TabletId: 72075186224037893 Status: Active } Partitions { PartitionId: 4 TabletId: 72075186224037893 Status: Active } AlterVersion: 1 BalancerTabletID: 72075186224037895 NextPartitionId: 5 } 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: 8 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: 5 PQPartitionsLimit: 1000000 } } PathId: 9 PathOwnerId: 72057594046644480 }, by path# { Subscriber: { Subscriber: [1:7565596442757344452:8414] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 1 } Filled: 1 Status: StatusSuccess Kind: 4 TableKind: 0 Created: 1 CreateStep: 1761502689093 PathId: [OwnerId: 72057594046644480, LocalPathId: 9] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, by pathId# { Subscriber: { Subscriber: [1:7565596442757344452:8414] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 1 } Filled: 1 Status: StatusSuccess Kind: 4 TableKind: 0 Created: 1 CreateStep: 1761502689093 PathId: [OwnerId: 72057594046644480, LocalPathId: 9] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }
2025-10-26T18:18:09.135742Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Handle TEvTxProxySchemeCache::TEvNavigateKeySet: self# [1:7565596399807669495:8201], request# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpPath RedirectRequired: false ShowPrivatePath: false SyncVersion: false Status: Unknown Kind: KindUnknown DomainInfo <null> }] }
2025-10-26T18:18:09.135862Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TNavigate: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596404102637264:8339] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 11 } Filled: 1 Status: StatusSuccess Kind: 2 TableKind: 0 Created: 1 CreateStep: 1761502680637 PathId: [OwnerId: 72057594046644480, LocalPathId: 1] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, entry# { Path: Root TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpPath RedirectRequired: false ShowPrivatePath: false SyncVersion: false Status: Unknown Kind: KindUnknown DomainInfo <null> }, props# { Cookie: 0 IsSync: false Partial: 0 }
2025-10-26T18:18:09.135998Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Send result: self# [1:7565596442757344472:8449], recipient# [1:7565596442757344470:8562], result# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root TableId: [72057594046644480:1:0] RequestType: ByPath Operation: OpPath RedirectRequired: false ShowPrivatePath: false SyncVersion: false Status: Ok Kind: KindPath DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } }] }
2025-10-26T18:18:09.143749Z node 1 :KQP_PROXY DEBUG: TraceId: "01k8gvvxvq80v2kbade4ysb5vf", Request has 18444982571020.407894s seconds to be completed
2025-10-26T18:18:09.145393Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [0:0:0], ActorState: unknown state, Create session actor with id N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==
2025-10-26T18:18:09.145493Z node 1 :KQP_PROXY DEBUG: TraceId: "01k8gvvxvq80v2kbade4ysb5vf", Created new session, sessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, workerId: [1:7565596442757344475:4326], database: /Root, longSession: 1, local sessions count: 1
2025-10-26T18:18:09.145512Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: unknown state, session actor bootstrapped
2025-10-26T18:18:09.145603Z node 1 :KQP_PROXY DEBUG: Received create session request, trace_id: 01k8gvvxvq80v2kbade4ysb5vf
2025-10-26T18:18:09.150586Z node 1 :KQP_PROXY DEBUG: Ctx: { TraceId: 01k8gvvxvy4ytkvs174r5jftvn, Database: /Root, DatabaseId: , SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. TEvQueryRequest, set timer for: 600.000000s timeout: 0.000000s cancelAfter: 0.000000s. Send request to target, requestId: 17, targetId: [1:7565596442757344475:4326]
2025-10-26T18:18:09.150621Z node 1 :KQP_PROXY DEBUG: Scheduled timeout timer for requestId: 17 timeout: 600.000000s actor id: [1:7565596442757344478:8680]
2025-10-26T18:18:09.150789Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ReadyState, TraceId: 01k8gvvxvy4ytkvs174r5jftvn, received request, proxyRequestId: 17 prepared: 0 tx_control: 1 action: QUERY_ACTION_BEGIN_TX type: QUERY_TYPE_UNDEFINED text:  rpcActor: [0:0:0] database: /Root databaseId: /Root pool id: 
2025-10-26T18:18:09.150917Z node 1 :KQP_SESSION INFO: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ReadyState, TraceId: 01k8gvvxvy4ytkvs174r5jftvn, txInfo  Status: Active Kind: Pure TotalDuration: 0 ServerDuration: 0.034 QueriesCount: 1
2025-10-26T18:18:09.150970Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ReadyState, TraceId: 01k8gvvxvy4ytkvs174r5jftvn, Create QueryResponse for action: QUERY_ACTION_BEGIN_TX with SUCCESS status
2025-10-26T18:18:09.151017Z node 1 :KQP_SESSION INFO: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ReadyState, TraceId: 01k8gvvxvy4ytkvs174r5jftvn, Cleanup start, isFinal: 0 CleanupCtx: 0 TransactionsToBeAborted.size(): 0 WorkerId: [0:0:0] WorkloadServiceCleanup: 0
2025-10-26T18:18:09.151046Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ReadyState, TraceId: 01k8gvvxvy4ytkvs174r5jftvn, EndCleanup, isFinal: 0
2025-10-26T18:18:09.151105Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ReadyState, TraceId: 01k8gvvxvy4ytkvs174r5jftvn, Sent query response back to proxy, proxyRequestId: 17, proxyId: [1:7565596399807669470:12300]
2025-10-26T18:18:09.151148Z node 1 :KQP_PROXY DEBUG: TraceId: "01k8gvvxvy4ytkvs174r5jftvn", Forwarded response to sender actor, requestId: 17, sender: [1:7565596442757344477:8580], selfId: [1:7565596399807669470:12300], source: [1:7565596442757344475:4326]
2025-10-26T18:18:09.157334Z node 1 :KQP_PROXY DEBUG: Ctx: { TraceId: 01k8gvvxw41pkatbn6fjgwhmm5, Database: /Root, DatabaseId: , SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. TEvQueryRequest, set timer for: 600.000000s timeout: 0.000000s cancelAfter: 0.000000s. Send request to target, requestId: 18, targetId: [1:7565596442757344475:4326]
2025-10-26T18:18:09.157390Z node 1 :KQP_PROXY DEBUG: Scheduled timeout timer for requestId: 18 timeout: 600.000000s actor id: [1:7565596442757344481:8661]
2025-10-26T18:18:09.157543Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ReadyState, TraceId: 01k8gvvxw41pkatbn6fjgwhmm5, received request, proxyRequestId: 18 prepared: 0 tx_control: 1 action: QUERY_ACTION_TOPIC type: QUERY_TYPE_UNDEFINED text:  rpcActor: [0:0:0] database: /Root databaseId: /Root pool id: 
2025-10-26T18:18:09.157805Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Handle TEvTxProxySchemeCache::TEvNavigateKeySet: self# [1:7565596399807669495:8201], request# { ErrorCount: 0 DatabaseName: /Root DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root/PQ/rt3.dc1--topic1 TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpList RedirectRequired: true ShowPrivatePath: true SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }] }
2025-10-26T18:18:09.158121Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: HandleNotify: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ/rt3.dc1--topic1 PathId: <Invalid> Partial: 0 }
2025-10-26T18:18:09.158189Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: ResolveCacheItem: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ/rt3.dc1--topic1 PathId: <Invalid> Partial: 0 }, by path# { Subscriber: { Subscriber: [1:7565596442757344452:8414] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 2 } Filled: 1 Status: StatusSuccess Kind: 4 TableKind: 0 Created: 1 CreateStep: 1761502689093 PathId: [OwnerId: 72057594046644480, LocalPathId: 9] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, by pathId# nullptr
2025-10-26T18:18:09.158237Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TNavigate: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596442757344452:8414] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 2 } Filled: 1 Status: StatusSuccess Kind: 4 TableKind: 0 Created: 1 CreateStep: 1761502689093 PathId: [OwnerId: 72057594046644480, LocalPathId: 9] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, entry# { Path: Root/PQ/rt3.dc1--topic1 TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpList RedirectRequired: true ShowPrivatePath: true SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }, props# { Cookie: 2 IsSync: true Partial: 0 }
2025-10-26T18:18:09.158358Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Send result: self# [1:7565596442757344482:8430], recipient# [1:7565596442757344475:4326], result# { ErrorCount: 0 DatabaseName: /Root DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root/PQ/rt3.dc1--topic1 TableId: [72057594046644480:9:0] RequestType: ByPath Operation: OpList RedirectRequired: true ShowPrivatePath: true SyncVersion: true Status: Ok Kind: KindTopic DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } }] }
2025-10-26T18:18:09.158444Z node 1 :KQP_SESSION DEBUG: (topic, partition, tablet): '/Root/PQ/rt3.dc1--topic1', 1, 72075186224037892
2025-10-26T18:18:09.158456Z node 1 :KQP_SESSION DEBUG: (topic, partition, tablet): '/Root/PQ/rt3.dc1--topic1', 4, 72075186224037893
2025-10-26T18:18:09.158545Z node 1 :KQP_SESSION INFO: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ExecuteState, TraceId: 01k8gvvxw41pkatbn6fjgwhmm5, txInfo  Status: Active Kind: Pure TotalDuration: 0 ServerDuration: 7.671 QueriesCount: 1
2025-10-26T18:18:09.158628Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ExecuteState, TraceId: 01k8gvvxw41pkatbn6fjgwhmm5, Create QueryResponse for action: QUERY_ACTION_TOPIC with SUCCESS status
2025-10-26T18:18:09.158692Z node 1 :KQP_SESSION INFO: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ExecuteState, TraceId: 01k8gvvxw41pkatbn6fjgwhmm5, Cleanup start, isFinal: 0 CleanupCtx: 0 TransactionsToBeAborted.size(): 0 WorkerId: [0:0:0] WorkloadServiceCleanup: 0
2025-10-26T18:18:09.158714Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ExecuteState, TraceId: 01k8gvvxw41pkatbn6fjgwhmm5, EndCleanup, isFinal: 0
2025-10-26T18:18:09.158762Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ExecuteState, TraceId: 01k8gvvxw41pkatbn6fjgwhmm5, Sent query response back to proxy, proxyRequestId: 18, proxyId: [1:7565596399807669470:12300]
2025-10-26T18:18:09.158809Z node 1 :KQP_PROXY DEBUG: TraceId: "01k8gvvxw41pkatbn6fjgwhmm5", Forwarded response to sender actor, requestId: 18, sender: [1:7565596442757344480:8679], selfId: [1:7565596399807669470:12300], source: [1:7565596442757344475:4326]
2025-10-26T18:18:09.166832Z node 1 :KQP_PROXY DEBUG: Ctx: { TraceId: 01k8gvvxwe7e9gwtxswm860r6d, Database: /Root, DatabaseId: , SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. TEvQueryRequest, set timer for: 600.000000s timeout: 0.000000s cancelAfter: 0.000000s. Send request to target, requestId: 19, targetId: [1:7565596442757344475:4326]
2025-10-26T18:18:09.166878Z node 1 :KQP_PROXY DEBUG: Scheduled timeout timer for requestId: 19 timeout: 600.000000s actor id: [1:7565596442757344485:8432]
2025-10-26T18:18:09.167048Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ReadyState, TraceId: 01k8gvvxwe7e9gwtxswm860r6d, received request, proxyRequestId: 19 prepared: 0 tx_control: 1 action: QUERY_ACTION_TOPIC type: QUERY_TYPE_UNDEFINED text:  rpcActor: [0:0:0] database: /Root databaseId: /Root pool id: 
2025-10-26T18:18:09.167186Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Handle TEvTxProxySchemeCache::TEvNavigateKeySet: self# [1:7565596399807669495:8201], request# { ErrorCount: 0 DatabaseName: /Root DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root/PQ/rt3.dc1--topic1 TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpList RedirectRequired: true ShowPrivatePath: true SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }] }
2025-10-26T18:18:09.167430Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: HandleNotify: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ/rt3.dc1--topic1 PathId: <Invalid> Partial: 0 }
2025-10-26T18:18:09.167475Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: ResolveCacheItem: self# [1:7565596399807669495:8201], notify# NKikimr::NSchemeBoard::NInternalEvents::TEvSyncResponse { Path: /Root/PQ/rt3.dc1--topic1 PathId: <Invalid> Partial: 0 }, by path# { Subscriber: { Subscriber: [1:7565596442757344452:8414] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 3 } Filled: 1 Status: StatusSuccess Kind: 4 TableKind: 0 Created: 1 CreateStep: 1761502689093 PathId: [OwnerId: 72057594046644480, LocalPathId: 9] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, by pathId# nullptr
2025-10-26T18:18:09.167522Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: FillEntry for TNavigate: self# [1:7565596399807669495:8201], cacheItem# { Subscriber: { Subscriber: [1:7565596442757344452:8414] DomainOwnerId: 72057594046644480 Type: 2 SyncCookie: 3 } Filled: 1 Status: StatusSuccess Kind: 4 TableKind: 0 Created: 1 CreateStep: 1761502689093 PathId: [OwnerId: 72057594046644480, LocalPathId: 9] DomainId: [OwnerId: 72057594046644480, LocalPathId: 1] IsPrivatePath: 0 IsVirtual: 0 SchemaVersion: 0 }, entry# { Path: Root/PQ/rt3.dc1--topic1 TableId: [18446744073709551615:18446744073709551615:0] RequestType: ByPath Operation: OpList RedirectRequired: true ShowPrivatePath: true SyncVersion: true Status: Unknown Kind: KindUnknown DomainInfo <null> }, props# { Cookie: 3 IsSync: true Partial: 0 }
2025-10-26T18:18:09.167653Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Send result: self# [1:7565596442757344486:8352], recipient# [1:7565596442757344475:4326], result# { ErrorCount: 0 DatabaseName: /Root DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root/PQ/rt3.dc1--topic1 TableId: [72057594046644480:9:0] RequestType: ByPath Operation: OpList RedirectRequired: true ShowPrivatePath: true SyncVersion: true Status: Ok Kind: KindTopic DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) } }] }
2025-10-26T18:18:09.167714Z node 1 :KQP_SESSION DEBUG: (topic, partition, tablet): '/Root/PQ/rt3.dc1--topic1', 1, 72075186224037892
2025-10-26T18:18:09.167763Z node 1 :KQP_SESSION INFO: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ExecuteState, TraceId: 01k8gvvxwe7e9gwtxswm860r6d, txInfo  Status: Active Kind: Pure TotalDuration: 0 ServerDuration: 24.56 QueriesCount: 1
2025-10-26T18:18:09.167796Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ExecuteState, TraceId: 01k8gvvxwe7e9gwtxswm860r6d, Create QueryResponse for action: QUERY_ACTION_TOPIC with SUCCESS status
2025-10-26T18:18:09.167832Z node 1 :KQP_SESSION INFO: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ExecuteState, TraceId: 01k8gvvxwe7e9gwtxswm860r6d, Cleanup start, isFinal: 0 CleanupCtx: 0 TransactionsToBeAborted.size(): 0 WorkerId: [0:0:0] WorkloadServiceCleanup: 0
2025-10-26T18:18:09.167852Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ExecuteState, TraceId: 01k8gvvxwe7e9gwtxswm860r6d, EndCleanup, isFinal: 0
2025-10-26T18:18:09.167904Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ExecuteState, TraceId: 01k8gvvxwe7e9gwtxswm860r6d, Sent query response back to proxy, proxyRequestId: 19, proxyId: [1:7565596399807669470:12300]
2025-10-26T18:18:09.167971Z node 1 :KQP_PROXY DEBUG: TraceId: "01k8gvvxwe7e9gwtxswm860r6d", Forwarded response to sender actor, requestId: 19, sender: [1:7565596442757344484:8661], selfId: [1:7565596399807669470:12300], source: [1:7565596442757344475:4326]
2025-10-26T18:18:09.176654Z node 1 :KQP_SESSION INFO: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ReadyState, Session closed due to explicit close event
2025-10-26T18:18:09.176759Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ReadyState, Sending to Executer TraceId: 0 8
2025-10-26T18:18:09.176843Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ReadyState, Created new KQP executer: [1:7565596442757344489:4326] isRollback: 1
2025-10-26T18:18:09.176901Z node 1 :KQP_SESSION INFO: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: ReadyState, Cleanup start, isFinal: 1 CleanupCtx: 1 TransactionsToBeAborted.size(): 1 WorkerId: [0:0:0] WorkloadServiceCleanup: 0
2025-10-26T18:18:09.176991Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Handle TEvTxProxySchemeCache::TEvResolveKeySet: self# [1:7565596399807669495:8201], request# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 ResultSet [] }
2025-10-26T18:18:09.177066Z node 1 :TX_PROXY_SCHEME_CACHE DEBUG: Send result: self# [1:7565596442757344491:8323], recipient# [1:7565596442757344490:4326], result# { ErrorCount: 0 DatabaseName:  DomainOwnerId: 0 ResultSet [] }
2025-10-26T18:18:09.177122Z node 1 :KQP_EXECUTER DEBUG: TxId: 281474976715674. Resolved key sets: 0
2025-10-26T18:18:09.177195Z node 1 :KQP_EXECUTER DEBUG: TxId: 281474976715674. Ctx: { TraceId: , Database: /Root, DatabaseId: , SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Total tasks: 0, readonly: true, 0 scan tasks on 0 nodes, pool: Data, localComputeTasks: 0, snapshot: {0, 0}
2025-10-26T18:18:09.177247Z node 1 :KQP_EXECUTER INFO: ActorId: [1:7565596442757344489:4326] TxId: 281474976715674. Ctx: { TraceId: , Database: /Root, DatabaseId: , SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Total tasks: 0, readonly: 1, datashardTxs: 0, evWriteTxs: 0, topicTxs: 0, volatile: 0, immediate: 1, pending compute tasks0, useFollowers: 0
2025-10-26T18:18:09.177314Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344489:4326] TxId: 281474976715674. Ctx: { TraceId: , Database: /Root, DatabaseId: , SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. terminate execution.
2025-10-26T18:18:09.177342Z node 1 :KQP_EXECUTER DEBUG: ActorId: [1:7565596442757344489:4326] TxId: 281474976715674. Ctx: { TraceId: , Database: /Root, DatabaseId: , SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Resource usage for last stat interval: ComputeTime: 0.000000s ReadRows: 0 ReadBytes: 0 ru: 1 rate limiter was not found force flag: 1
2025-10-26T18:18:09.177407Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: CleanupState, EndCleanup, isFinal: 1
2025-10-26T18:18:09.177429Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: unknown state, Cleanup temp tables: 0
2025-10-26T18:18:09.177524Z node 1 :KQP_SESSION DEBUG: SessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, ActorId: [1:7565596442757344475:4326], ActorState: unknown state, Session actor destroyed
2025-10-26T18:18:09.177591Z node 1 :KQP_PROXY DEBUG: Session closed, sessionId: ydb://session/3?node_id=1&id=N2Q0MGZlYWYtZGIwNWFiNTctMzY5YTEyNjgtNDU1YmMyMQ==, workerId: [1:7565596442757344475:4326], local sessions count: 0
