2025-11-14T10:38:39.268273Z node 4 :METADATA_PROVIDER ERROR: fline=accessor_snapshot_base.cpp:69;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=incorrect path status: LookupError;
test_client.cpp: SetPath # /home/runner/.ya/build/build_root/haex/0022ea/r3tmp/tmp9Aaq3m/pdisk_1.dat
2025-11-14T10:38:39.720172Z node 4 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 1:0, at schemeshard:  72057594046644480
2025-11-14T10:38:39.789970Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-14T10:38:39.790126Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-14T10:38:39.814680Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-11-14T10:38:40.158802Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:964:2778], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:40.158888Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:40.158928Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:38:40.159059Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [4:961:2776], Recipient [4:529:2441]: {TEvModifySchemeTransaction txid# 281474976715657 TabletId# 72057594046644480}
2025-11-14T10:38:40.159093Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-11-14T10:38:40.241518Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Execute, message: Transaction { WorkingDir: "/Root" OperationType: ESchemeOpCreateSubDomain SubDomain { Name: "tenant" } } TxId: 281474976715657 TabletId: 72057594046644480 PeerName: "" , at schemeshard: 72057594046644480
2025-11-14T10:38:40.241759Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TCreateSubDomain Propose, path: /Root/tenant, opId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T10:38:40.241864Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: AttachChild: child attached as only one child to the parent, parent id: [OwnerId: 72057594046644480, LocalPathId: 1], parent name: Root, child name: tenant, child id: [OwnerId: 72057594046644480, LocalPathId: 2], at schemeshard: 72057594046644480
2025-11-14T10:38:40.242003Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 0
2025-11-14T10:38:40.242168Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason  for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 1
2025-11-14T10:38:40.242281Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976715657:1, propose status:StatusAccepted, reason: , at schemeshard: 72057594046644480
2025-11-14T10:38:40.242334Z node 4 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateSubDomain, opId: 281474976715657:0, at schemeshard:  72057594046644480
2025-11-14T10:38:40.242421Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:40.242481Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 1
2025-11-14T10:38:40.242534Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T10:38:40.244697Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976715657, response: Status: StatusAccepted TxId: 281474976715657 SchemeshardId: 72057594046644480 PathId: 2, at schemeshard: 72057594046644480
2025-11-14T10:38:40.244862Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976715657, database: /Root, subject: , status: StatusAccepted, operation: CREATE DATABASE, path: /Root/tenant
2025-11-14T10:38:40.244923Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:40.244975Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T10:38:40.245293Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:38:40.245332Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:38:40.245493Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T10:38:40.245543Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 1]
2025-11-14T10:38:40.245716Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T10:38:40.245807Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T10:38:40.245852Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 1
2025-11-14T10:38:40.245900Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 2
2025-11-14T10:38:40.245997Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T10:38:40.246073Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715657:0 ProgressState, operation type: TxCreateSubDomain, at tablet# 72057594046644480
2025-11-14T10:38:40.246118Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715657:0 ProgressState no shards to create, do next state
2025-11-14T10:38:40.246156Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715657:0 2 -> 3
2025-11-14T10:38:40.246244Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:40.246917Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:964:2778], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:38:40.246961Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:38:40.247006Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T10:38:40.249097Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 1] Version: 4 }
2025-11-14T10:38:40.249150Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:38:40.249245Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 1 Version: 4 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:38:40.249359Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 1 Version: 4 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:38:40.249397Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T10:38:40.249445Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 1], version: 4
2025-11-14T10:38:40.249490Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 2
2025-11-14T10:38:40.249582Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:40.250072Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 2 }
2025-11-14T10:38:40.250109Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:38:40.250176Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 2 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:38:40.250253Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 2 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:38:40.250277Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T10:38:40.250302Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 2
2025-11-14T10:38:40.250328Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 3
2025-11-14T10:38:40.250392Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715657, ready parts: 0/1, is published: true
2025-11-14T10:38:40.250430Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:40.253229Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:40.253284Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T10:38:40.253597Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:38:40.253631Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:38:40.253703Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T10:38:40.253761Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715657:0 ProgressState, at schemeshard: 72057594046644480
2025-11-14T10:38:40.253805Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715657:0 3 -> 128
2025-11-14T10:38:40.253893Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:40.254314Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T10:38:40.254361Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:40.256585Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T10:38:40.256619Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:40.259685Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:40.259725Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T10:38:40.259873Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:38:40.259921Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:38:40.259970Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T10:38:40.260025Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose ProgressState, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T10:38:40.260086Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose ProgressState leave, operationId 281474976715657:0, at tablet# 72057594046644480
2025-11-14T10:38:40.260121Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:40.260187Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976715657 ready parts: 1/1
2025-11-14T10:38:40.280605Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoPropose send propose to coordinator: 72057594046316545 message:Transaction { AffectedSet { TabletId: 72057594046644480 Flags: 2 } ExecLevel: 0 TxId: 281474976715657 MinStep: 0 MaxStep: 18446744073709551615 IgnoreLowDiskSpace: true } CoordinatorID: 72057594046316545
2025-11-14T10:38:40.283006Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:40.283082Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715657:4294967295 from tablet: 72057594046644480 to tablet: 72057594046316545 cookie: 0:281474976715657 msg type: 269090816
2025-11-14T10:38:40.283214Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715657, partId: 4294967295, tablet: 72057594046316545
2025-11-14T10:38:40.283539Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:520:2432], Recipient [4:529:2441]: NKikimrTx.TEvProposeTransactionStatus Status: 16 StepId: 1000 TxId: 281474976715657
2025-11-14T10:38:40.284045Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:984:2798], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:40.284103Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:40.284144Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:38:40.284301Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124996, Sender [4:904:2725], Recipient [4:529:2441]: NKikimrScheme.TEvNotifyTxCompletion TxId: 281474976715657
2025-11-14T10:38:40.284336Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvNotifyTxCompletion
2025-11-14T10:38:40.284403Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NotifyTxCompletion operation in-flight, txId: 281474976715657, at schemeshard: 72057594046644480
2025-11-14T10:38:40.284448Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715657, ready parts: 0/1, is published: true
2025-11-14T10:38:40.284517Z node 4 :FLAT_TX_SCHEMESHARD INFO: NotifyTxCompletion transaction is registered, txId: 281474976715657, at schemeshard: 72057594046644480
2025-11-14T10:38:40.638613Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:520:2432], Recipient [4:529:2441]: NKikimrTx.TEvProposeTransactionStatus Status: 17 StepId: 1000 TxId: 281474976715657
2025-11-14T10:38:40.639029Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [4:750:2598], Recipient [4:529:2441]: {TEvPlanStep step# 1000 MediatorId# 72057594046382081 TabletID 72057594046644480}
2025-11-14T10:38:40.639075Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-11-14T10:38:40.639165Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1000, transactions count in step: 1, at schemeshard: 72057594046644480
2025-11-14T10:38:40.639323Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPlanStep Execute, message: Transactions { TxId: 281474976715657 AckTo { RawX1: 0 RawX2: 0 } } Step: 1000 MediatorID: 72057594046382081 TabletID: 72057594046644480, at schemeshard: 72057594046644480
2025-11-14T10:38:40.639388Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715657:0, at tablet# 72057594046644480
2025-11-14T10:38:40.639599Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715657:0 128 -> 240
2025-11-14T10:38:40.639665Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715657:0, at tablet# 72057594046644480
2025-11-14T10:38:40.639831Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:40.639918Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 1
2025-11-14T10:38:40.640003Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T10:38:40.640047Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715657:4294967295 from tablet: 72057594046644480 to tablet: 0 cookie: 0:281474976715657
2025-11-14T10:38:40.640095Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DoUpdateTenant no IsExternalSubDomainRoot, pathId: : [OwnerId: 72057594046644480, LocalPathId: 2], at schemeshard: 72057594046644480
2025-11-14T10:38:40.645600Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:40.645686Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1000
2025-11-14T10:38:40.645750Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T10:38:40.645992Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:38:40.646036Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:38:40.646449Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T10:38:40.646507Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 1]
2025-11-14T10:38:40.646705Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T10:38:40.646838Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T10:38:40.646888Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 1
2025-11-14T10:38:40.646942Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 2
2025-11-14T10:38:40.647538Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T10:38:40.647621Z node 4 :FLAT_TX_SCHEMESHARD INFO: [72057594046644480] TDone opId# 281474976715657:0 ProgressState
2025-11-14T10:38:40.647747Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:40.647791Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715657:0 progress is 1/1
2025-11-14T10:38:40.647831Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715657 ready parts: 1/1
2025-11-14T10:38:40.647876Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715657:0 progress is 1/1
2025-11-14T10:38:40.647916Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715657 ready parts: 1/1
2025-11-14T10:38:40.647956Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715657, ready parts: 1/1, is published: false
2025-11-14T10:38:40.648009Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715657 ready parts: 1/1
2025-11-14T10:38:40.648056Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976715657:0
2025-11-14T10:38:40.648097Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976715657:0
2025-11-14T10:38:40.648176Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 3
2025-11-14T10:38:40.648223Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication still in progress, tx: 281474976715657, publications: 2, subscribers: 1
2025-11-14T10:38:40.648258Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Publication details:  tx: 281474976715657, [OwnerId: 72057594046644480, LocalPathId: 1], 5
2025-11-14T10:38:40.648290Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Publication details:  tx: 281474976715657, [OwnerId: 72057594046644480, LocalPathId: 2], 3
2025-11-14T10:38:40.649406Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 1] Version: 5 }
2025-11-14T10:38:40.649466Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:38:40.649584Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 1 Version: 5 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:38:40.649700Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 1 Version: 5 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:38:40.649740Z node 4 :FLAT_TX_SCHEMESHARD INFO: Publication in-flight, count: 2, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T10:38:40.649786Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 1], version: 5
2025-11-14T10:38:40.649831Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 2
2025-11-14T10:38:40.649916Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:40.651219Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 3 }
2025-11-14T10:38:40.651260Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:38:40.651316Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 3 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:38:40.651380Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 3 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:38:40.651406Z node 4 :FLAT_TX_SCHEMESHARD INFO: Publication in-flight, count: 1, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T10:38:40.651450Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 3
2025-11-14T10:38:40.651485Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T10:38:40.651554Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication complete, notify & remove, at schemeshard: 72057594046644480, txId: 281474976715657, subscribers: 1
2025-11-14T10:38:40.651599Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Notify send TEvNotifyTxCompletionResult, at schemeshard: 72057594046644480, to actorId: [4:904:2725]
2025-11-14T10:38:40.651646Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:40.655285Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:40.655966Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T10:38:40.656034Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:40.656152Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T10:38:40.656178Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:40.656257Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [4:904:2725] msg type: 271124998 msg: NKikimrScheme.TEvNotifyTxCompletionResult TxId: 281474976715657 at schemeshard: 72057594046644480
2025-11-14T10:38:40.659507Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1013:2820], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:40.659574Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:40.659612Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:38:40.659785Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [4:1003:2817], Recipient [4:529:2441]: {TEvModifySchemeTransaction txid# 281474976715658 TabletId# 72057594046644480}
2025-11-14T10:38:40.659825Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-11-14T10:38:40.662615Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Execute, message: Transaction { WorkingDir: "/Root" OperationType: ESchemeOpAlterSubDomain SubDomain { PlanResolution: 10 Coordinators: 1 Mediators: 1 Name: "tenant" TimeCastBucketsPerMediator: 2 StoragePools { Name: "/Root:ssd" Kind: "ssd" } StoragePools { Name: "/Root:hdd" Kind: "hdd" } DatabaseQuotas { storage_quotas { unit_kind: "hdd" data_size_hard_quota: 1 } } } } TxId: 281474976715658 TabletId: 72057594046644480 PeerName: "" , at schemeshard: 72057594046644480
2025-11-14T10:38:40.663831Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TAlterSubDomain Propose, path: /Root/tenant, opId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:38:40.664083Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 1
2025-11-14T10:38:40.664159Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T10:38:40.664221Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 3
2025-11-14T10:38:40.664602Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976715658:1, propose status:StatusAccepted, reason: , at schemeshard: 72057594046644480
2025-11-14T10:38:40.664684Z node 4 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 281474976715658:0, at schemeshard:  72057594046644480
2025-11-14T10:38:40.664815Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:40.669079Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976715658, response: Status: StatusAccepted TxId: 281474976715658 SchemeshardId: 72057594046644480 PathId: 2, at schemeshard: 72057594046644480
2025-11-14T10:38:40.669293Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976715658, database: /Root, subject: , status: StatusAccepted, operation: ALTER DATABASE, path: /Root/tenant
2025-11-14T10:38:40.669359Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:40.669402Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T10:38:40.669709Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:38:40.669752Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:38:40.669816Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:38:40.669878Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715658:0 ProgressState, operation type: TxAlterSubDomain, at tablet# 72057594046644480
2025-11-14T10:38:40.670151Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715658:0 CreateRequest Event to Hive: 72057594037968897 msg:  Owner: 72057594046644480
OwnerIdx: 1
TabletType: Coordinator
ObjectDomain {
  SchemeShard: 72057594046644480
  PathId: 2
}
ObjectId: 2
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
AllowedDomains {
  SchemeShard: 72057594046644480
  PathId: 2
}
2025-11-14T10:38:40.670273Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715658:0 CreateRequest Event to Hive: 72057594037968897 msg:  Owner: 72057594046644480
OwnerIdx: 2
TabletType: Mediator
ObjectDomain {
  SchemeShard: 72057594046644480
  PathId: 2
}
ObjectId: 2
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
AllowedDomains {
  SchemeShard: 72057594046644480
  PathId: 2
}
2025-11-14T10:38:40.670324Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:40.670708Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1013:2820], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:38:40.670752Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:38:40.670793Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T10:38:40.673058Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:40.673125Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:1 msg type: 268697601
2025-11-14T10:38:40.673287Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:2 msg type: 268697601
2025-11-14T10:38:40.673361Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 0, tablet: 72057594037968897
2025-11-14T10:38:40.673415Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:1, partId: 0
2025-11-14T10:38:40.673463Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:2, partId: 0
2025-11-14T10:38:40.673927Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1020:2827], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72057594037968897 Status: OK ServerId: [4:1021:2828] Leader: 1 Dead: 0 Generation: 2 VersionInfo:  }
2025-11-14T10:38:40.673974Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T10:38:40.674018Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72057594037968897, status: OK, at schemeshard: 72057594046644480
2025-11-14T10:38:43.543625Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1302:2843], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:43.543702Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:43.543742Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:38:43.555278Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122945, Sender [5:1259:2343], Recipient [4:1302:2843]
2025-11-14T10:38:43.555359Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvDescribeScheme
2025-11-14T10:38:43.558084Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1316:2848], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:43.558138Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:43.558164Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:38:43.558698Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [4:1293:2839], Recipient [4:529:2441]: {TEvModifySchemeTransaction txid# 281474976715659 TabletId# 72057594046644480}
2025-11-14T10:38:43.558741Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-11-14T10:38:43.561529Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Execute, message: Transaction { WorkingDir: "/Root/tenant" OperationType: ESchemeOpCreateTable CreateTable { Name: "table" Columns { Name: "Key" Type: "Uint32" NotNull: false } Columns { Name: "Value" Type: "Utf8" FamilyName: "hdd" NotNull: false } KeyColumnNames: "Key" PartitionConfig { ColumnFamilies { ColumnCodec: ColumnCodecPlain StorageConfig { SysLog { PreferredPoolKind: "ssd" } Log { PreferredPoolKind: "ssd" } Data { PreferredPoolKind: "ssd" AllowOtherKinds: false } } } ColumnFamilies { Name: "hdd" ColumnCodec: ColumnCodecLZ4 StorageConfig { Data { PreferredPoolKind: "hdd" AllowOtherKinds: false } } } } Temporary: false } } TxId: 281474976715659 TabletId: 72057594046644480 PeerName: "" , at schemeshard: 72057594046644480
2025-11-14T10:38:43.562025Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TCreateTable Propose, path: /Root/tenant/table, opId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:38:43.562224Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable Propose, path: /Root/tenant/table, opId: 281474976715659:0, schema: Name: "table" Columns { Name: "Key" Type: "Uint32" NotNull: false } Columns { Name: "Value" Type: "Utf8" FamilyName: "hdd" NotNull: false } KeyColumnNames: "Key" PartitionConfig { ColumnFamilies { ColumnCodec: ColumnCodecPlain StorageConfig { SysLog { PreferredPoolKind: "ssd" } Log { PreferredPoolKind: "ssd" } Data { PreferredPoolKind: "ssd" AllowOtherKinds: false } } } ColumnFamilies { Name: "hdd" ColumnCodec: ColumnCodecLZ4 StorageConfig { Data { PreferredPoolKind: "hdd" AllowOtherKinds: false } } } } Temporary: false, at schemeshard: 72057594046644480
2025-11-14T10:38:43.562858Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: AttachChild: child attached as only one child to the parent, parent id: [OwnerId: 72057594046644480, LocalPathId: 2], parent name: tenant, child name: table, child id: [OwnerId: 72057594046644480, LocalPathId: 3], at schemeshard: 72057594046644480
2025-11-14T10:38:43.562937Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 0
2025-11-14T10:38:43.563019Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 1
2025-11-14T10:38:43.563155Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new path created for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 2
2025-11-14T10:38:43.563220Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 1 -> 2
2025-11-14T10:38:43.563967Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TCreateTable Propose creating new table opId# 281474976715659:0 path# /Root/tenant/table pathId# [OwnerId: 72057594046644480, LocalPathId: 3] schemeshard# 72057594046644480 tx# WorkingDir: "/Root/tenant"
OperationType: ESchemeOpCreateTable
CreateTable {
  Name: "table"
  Columns {
    Name: "Key"
    Type: "Uint32"
    NotNull: false
  }
  Columns {
    Name: "Value"
    Type: "Utf8"
    FamilyName: "hdd"
    NotNull: false
  }
  KeyColumnNames: "Key"
  PartitionConfig {
    ColumnFamilies {
      ColumnCodec: ColumnCodecPlain
      StorageConfig {
        SysLog {
          PreferredPoolKind: "ssd"
        }
        Log {
          PreferredPoolKind: "ssd"
        }
        Data {
          PreferredPoolKind: "ssd"
          AllowOtherKinds: false
        }
      }
    }
    ColumnFamilies {
      Name: "hdd"
      ColumnCodec: ColumnCodecLZ4
      StorageConfig {
        Data {
          PreferredPoolKind: "hdd"
          AllowOtherKinds: false
        }
      }
    }
  }
  Temporary: false
}
FailOnExist: false
2025-11-14T10:38:43.564142Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976715659:1, propose status:StatusAccepted, reason: , at schemeshard: 72057594046644480
2025-11-14T10:38:43.564193Z node 4 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976715659:0, at schemeshard:  72057594046644480
2025-11-14T10:38:43.564326Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:43.564392Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T10:38:43.564448Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 3
2025-11-14T10:38:43.567893Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976715659, response: Status: StatusAccepted TxId: 281474976715659 SchemeshardId: 72057594046644480 PathId: 3, at schemeshard: 72057594046644480
2025-11-14T10:38:43.568089Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976715659, database: /Root/tenant, subject: , status: StatusAccepted, operation: CREATE TABLE, path: /Root/tenant/table
2025-11-14T10:38:43.568176Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:43.568218Z node 4 :FLAT_TX_SCHEMESHARD INFO: Delay activating, operation part: 281474976715659:0, there is await operations num 1
2025-11-14T10:38:43.568555Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T10:38:43.568596Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T10:38:43.568773Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 3]
2025-11-14T10:38:43.568854Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T10:38:43.568905Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 2
2025-11-14T10:38:43.568956Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 3
2025-11-14T10:38:43.569560Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1316:2848], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:38:43.569606Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:38:43.569642Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T10:38:43.570273Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 4 }
2025-11-14T10:38:43.570311Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:38:43.570391Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 4 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:38:43.570494Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 4 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:38:43.570534Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T10:38:43.570583Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 4
2025-11-14T10:38:43.570627Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 6
2025-11-14T10:38:43.570776Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:43.571242Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1332:2853], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:43.571274Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:43.571295Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:38:43.571533Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124996, Sender [4:1292:2838], Recipient [4:529:2441]: NKikimrScheme.TEvNotifyTxCompletion TxId: 281474976715659
2025-11-14T10:38:43.571569Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvNotifyTxCompletion
2025-11-14T10:38:43.571624Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NotifyTxCompletion operation in-flight, txId: 281474976715659, at schemeshard: 72057594046644480
2025-11-14T10:38:43.571661Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 0/1, is published: false
2025-11-14T10:38:43.571707Z node 4 :FLAT_TX_SCHEMESHARD INFO: NotifyTxCompletion transaction is registered, txId: 281474976715659, at schemeshard: 72057594046644480
2025-11-14T10:38:43.571941Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 3] Version: 1 }
2025-11-14T10:38:43.571975Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:38:43.572055Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 3 Version: 1 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:38:43.572131Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 3 Version: 1 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:38:43.572158Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T10:38:43.572186Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], version: 1
2025-11-14T10:38:43.572212Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 4
2025-11-14T10:38:43.572274Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 0/1, is published: true
2025-11-14T10:38:43.572310Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:43.577400Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T10:38:43.577477Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:43.577976Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T10:38:43.578005Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:43.579333Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(5, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-14T10:38:43.579433Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(5, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-14T10:38:43.615968Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [4:535:2446], Recipient [4:529:2441]: {EvCreateTabletReply Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897}
2025-11-14T10:38:43.616020Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-11-14T10:38:43.616141Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72057594046644480 message: Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897
2025-11-14T10:38:43.616205Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:1, partId: 0
2025-11-14T10:38:43.616338Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897
2025-11-14T10:38:43.616395Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, at tabletId: 72057594046644480
2025-11-14T10:38:43.616470Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, message: Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897
2025-11-14T10:38:43.616572Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:43.616623Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:1
2025-11-14T10:38:43.617008Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [4:535:2446], Recipient [4:529:2441]: {EvCreateTabletReply Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897}
2025-11-14T10:38:43.617050Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-11-14T10:38:43.617099Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72057594046644480 message: Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897
2025-11-14T10:38:43.617158Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:2, partId: 0
2025-11-14T10:38:43.617248Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897
2025-11-14T10:38:43.617277Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, at tabletId: 72057594046644480
2025-11-14T10:38:43.617325Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, message: Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897
2025-11-14T10:38:43.617396Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715658:0 2 -> 3
2025-11-14T10:38:43.617509Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:43.617555Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:2
2025-11-14T10:38:43.617714Z node 4 :HIVE WARN: HIVE#72057594037968897 Handle TEvInterconnect::TEvNodeConnected, NodeId 5 Cookie 5
2025-11-14T10:38:43.621170Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(5, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-11-14T10:38:43.622862Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:38:43.622914Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:43.623195Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:38:43.623227Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:43.623259Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T10:38:43.623397Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:38:43.623427Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:38:43.623477Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:38:43.623546Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715658:0 ProgressState, at schemeshard: 72057594046644480
2025-11-14T10:38:43.623621Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send configure request to coordinator/mediator: 72075186224037888 opId: 281474976715658:0 schemeshard: 72057594046644480
2025-11-14T10:38:43.623666Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send configure request to coordinator/mediator: 72075186224037889 opId: 281474976715658:0 schemeshard: 72057594046644480
2025-11-14T10:38:43.623705Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:43.625255Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:43.625303Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037888 cookie: 72057594046644480:1 msg type: 272564224
2025-11-14T10:38:43.625403Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037889 cookie: 72057594046644480:2 msg type: 272564224
2025-11-14T10:38:43.625493Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 0, tablet: 72075186224037888
2025-11-14T10:38:43.625533Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 0, tablet: 72075186224037889
2025-11-14T10:38:43.728674Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [4:535:2446], Recipient [4:529:2441]: {EvTabletCreationResult Status: OK TabletID: 72075186224037888}
2025-11-14T10:38:43.728772Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [4:535:2446], Recipient [4:529:2441]: {EvTabletCreationResult Status: OK TabletID: 72075186224037889}
2025-11-14T10:38:43.774684Z node 4 :TX_CONVEYOR ERROR: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-11-14T10:38:43.789306Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1351:2872], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72075186224037888 Status: OK ServerId: [5:1450:2403] Leader: 1 Dead: 0 Generation: 1 VersionInfo:  }
2025-11-14T10:38:43.789394Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T10:38:43.789456Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037888, status: OK, at schemeshard: 72057594046644480
2025-11-14T10:38:43.789630Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:43.789677Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:43.790761Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1352:2873], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72075186224037889 Status: OK ServerId: [5:1451:2404] Leader: 1 Dead: 0 Generation: 1 VersionInfo:  }
2025-11-14T10:38:43.790812Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T10:38:43.790864Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037889, status: OK, at schemeshard: 72057594046644480
2025-11-14T10:38:43.799476Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 272564225, Sender [5:1382:2370], Recipient [4:529:2441]
2025-11-14T10:38:43.799536Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSubDomain::TEvConfigureStatus
2025-11-14T10:38:43.799631Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715658, tablet: 72075186224037888, partId: 0
2025-11-14T10:38:43.799792Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: SUCCESS OnTabletId: 72075186224037888
2025-11-14T10:38:43.799909Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715658:0 HandleReply TEvConfigureStatus operationId:281474976715658:0 at schemeshard:72057594046644480
2025-11-14T10:38:43.799988Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TConfigureParts operationId# 281474976715658:0 Got OK TEvConfigureStatus from  tablet# 72075186224037888 shardIdx# 72057594046644480:1 at schemeshard# 72057594046644480
2025-11-14T10:38:43.800051Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:43.800108Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037888 cookie: 72057594046644480:1
2025-11-14T10:38:43.801300Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 272564225, Sender [5:1384:2371], Recipient [4:529:2441]
2025-11-14T10:38:43.801347Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSubDomain::TEvConfigureStatus
2025-11-14T10:38:43.801386Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715658, tablet: 72075186224037889, partId: 0
2025-11-14T10:38:43.801470Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: SUCCESS OnTabletId: 72075186224037889
2025-11-14T10:38:43.801503Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715658:0 HandleReply TEvConfigureStatus operationId:281474976715658:0 at schemeshard:72057594046644480
2025-11-14T10:38:43.801537Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TConfigureParts operationId# 281474976715658:0 Got OK TEvConfigureStatus from  tablet# 72075186224037889 shardIdx# 72057594046644480:2 at schemeshard# 72057594046644480
2025-11-14T10:38:43.801574Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715658:0 3 -> 128
2025-11-14T10:38:43.801671Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:43.801705Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037889 cookie: 72057594046644480:2
2025-11-14T10:38:43.808249Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:38:43.808310Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:43.811240Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:38:43.811288Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:43.811330Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T10:38:43.811550Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:38:43.811587Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:38:43.811651Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:38:43.811696Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose ProgressState, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:38:43.811755Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose ProgressState leave, operationId 281474976715658:0, at tablet# 72057594046644480
2025-11-14T10:38:43.811797Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:43.811845Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976715658 ready parts: 1/1
2025-11-14T10:38:43.812009Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoPropose send propose to coordinator: 72057594046316545 message:Transaction { AffectedSet { TabletId: 72057594046644480 Flags: 2 } ExecLevel: 0 TxId: 281474976715658 MinStep: 0 MaxStep: 18446744073709551615 IgnoreLowDiskSpace: true } CoordinatorID: 72057594046316545
2025-11-14T10:38:43.817745Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:43.817807Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715658:4294967295 from tablet: 72057594046644480 to tablet: 72057594046316545 cookie: 0:281474976715658 msg type: 269090816
2025-11-14T10:38:43.817905Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 4294967295, tablet: 72057594046316545
2025-11-14T10:38:43.818167Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:520:2432], Recipient [4:529:2441]: NKikimrTx.TEvProposeTransactionStatus Status: 16 StepId: 1500 TxId: 281474976715658
2025-11-14T10:38:44.137412Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:520:2432], Recipient [4:529:2441]: NKikimrTx.TEvProposeTransactionStatus Status: 17 StepId: 1500 TxId: 281474976715658
2025-11-14T10:38:44.137845Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [4:750:2598], Recipient [4:529:2441]: {TEvPlanStep step# 1500 MediatorId# 72057594046382081 TabletID 72057594046644480}
2025-11-14T10:38:44.137891Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-11-14T10:38:44.137969Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1500, transactions count in step: 1, at schemeshard: 72057594046644480
2025-11-14T10:38:44.138093Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPlanStep Execute, message: Transactions { TxId: 281474976715658 AckTo { RawX1: 0 RawX2: 0 } } Step: 1500 MediatorID: 72057594046382081 TabletID: 72057594046644480, at schemeshard: 72057594046644480
2025-11-14T10:38:44.138146Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715658:0, at tablet# 72057594046644480
2025-11-14T10:38:44.138476Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715658:0 128 -> 240
2025-11-14T10:38:44.138546Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715658:0, at tablet# 72057594046644480
2025-11-14T10:38:44.138679Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:44.138753Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T10:38:44.138821Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:4294967295 from tablet: 72057594046644480 to tablet: 0 cookie: 0:281474976715658
2025-11-14T10:38:44.138884Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DoUpdateTenant no IsExternalSubDomainRoot, pathId: : [OwnerId: 72057594046644480, LocalPathId: 2], at schemeshard: 72057594046644480
2025-11-14T10:38:44.141911Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.141970Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1500
2025-11-14T10:38:44.142052Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T10:38:44.142318Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:38:44.142359Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:38:44.142965Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T10:38:44.143006Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715658, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T10:38:44.143225Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T10:38:44.143263Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715658, path id: 2
2025-11-14T10:38:44.143384Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:38:44.143450Z node 4 :FLAT_TX_SCHEMESHARD INFO: [72057594046644480] TDone opId# 281474976715658:0 ProgressState
2025-11-14T10:38:44.143595Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:44.143649Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715658:0 progress is 1/1
2025-11-14T10:38:44.143694Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715658 ready parts: 1/1
2025-11-14T10:38:44.143757Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715658:0 progress is 1/1
2025-11-14T10:38:44.143798Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715658 ready parts: 1/1
2025-11-14T10:38:44.143842Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715658, ready parts: 1/1, is published: false
2025-11-14T10:38:44.143911Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715658 ready parts: 1/1
2025-11-14T10:38:44.143958Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Remove dependency, parent tx: 281474976715658, dependent tx: 281474976715659
2025-11-14T10:38:44.144073Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976715658:0
2025-11-14T10:38:44.144121Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976715658:0
2025-11-14T10:38:44.144309Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 6
2025-11-14T10:38:44.144378Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication still in progress, tx: 281474976715658, publications: 1, subscribers: 0
2025-11-14T10:38:44.144420Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Publication details:  tx: 281474976715658, [OwnerId: 72057594046644480, LocalPathId: 2], 5
2025-11-14T10:38:44.145733Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 5 }
2025-11-14T10:38:44.145794Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:38:44.145875Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 5 PathOwnerId: 72057594046644480, cookie: 281474976715658
2025-11-14T10:38:44.145963Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 5 PathOwnerId: 72057594046644480, cookie: 281474976715658
2025-11-14T10:38:44.146003Z node 4 :FLAT_TX_SCHEMESHARD INFO: Publication in-flight, count: 1, at schemeshard: 72057594046644480, txId: 281474976715658
2025-11-14T10:38:44.146059Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715658, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 5
2025-11-14T10:38:44.146107Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T10:38:44.146224Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication complete, notify & remove, at schemeshard: 72057594046644480, txId: 281474976715658, subscribers: 0
2025-11-14T10:38:44.146269Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:44.150225Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.150275Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T10:38:44.150695Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:38:44.150742Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:38:44.150806Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:38:44.150865Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715659:0 ProgressState, operation type: TxCreateTable, at tablet# 72057594046644480
2025-11-14T10:38:44.151247Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715659:0 CreateRequest Event to Hive: 72057594037968897 msg:  Owner: 72057594046644480
OwnerIdx: 3
TabletType: DataShard
ObjectDomain {
  SchemeShard: 72057594046644480
  PathId: 2
}
ObjectId: 3
BindedChannels {
  StoragePoolName: "/Root:ssd"
  StoragePoolKind: "ssd"
}
BindedChannels {
  StoragePoolName: "/Root:ssd"
  StoragePoolKind: "ssd"
}
BindedChannels {
  StoragePoolName: "/Root:hdd"
  StoragePoolKind: "hdd"
}
AllowedDomains {
  SchemeShard: 72057594046644480
  PathId: 2
}
2025-11-14T10:38:44.151318Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:44.152941Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715658
2025-11-14T10:38:44.152994Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.155071Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.155120Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:3 msg type: 268697601
2025-11-14T10:38:44.155278Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715659, partId: 0, tablet: 72057594037968897
2025-11-14T10:38:44.155341Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976715659, shardIdx: 72057594046644480:3, partId: 0
2025-11-14T10:38:44.171348Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [4:535:2446], Recipient [4:529:2441]: {EvCreateTabletReply Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897}
2025-11-14T10:38:44.171418Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-11-14T10:38:44.171513Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72057594046644480 message: Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897
2025-11-14T10:38:44.171557Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976715659, shardIdx: 72057594046644480:3, partId: 0
2025-11-14T10:38:44.171683Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480, message: Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897
2025-11-14T10:38:44.171747Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715659:0 HandleReply TEvCreateTabletReply, at tabletId: 72057594046644480
2025-11-14T10:38:44.171823Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715659:0 HandleReply TEvCreateTabletReply, message: Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897
2025-11-14T10:38:44.171920Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 2 -> 3
2025-11-14T10:38:44.172016Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:44.172056Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:3
2025-11-14T10:38:44.177437Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:38:44.177516Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.177581Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T10:38:44.177769Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:38:44.177808Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:38:44.177855Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:38:44.177911Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TConfigureParts operationId# 281474976715659:0 ProgressState at tabletId# 72057594046644480
2025-11-14T10:38:44.178050Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable TConfigureParts operationId# 281474976715659:0 ProgressState Propose modify scheme on datashard datashardId: 72075186224037890 seqNo: 2:1
2025-11-14T10:38:44.178825Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable TConfigureParts operationId# 281474976715659:0 ProgressState Propose modify scheme on datashard datashardId: 72075186224037890 message: TxKind: TX_KIND_SCHEME SourceDeprecated { RawX1: 529 RawX2: 17179871625 } TxBody: "\n\211\005\n\005table\020\003\032\r\n\003Key\030\002 \001(\000@\000\032\020\n\005Value\030\200$ \002(\001@\000(\001:\243\004\022\253\003\010\200\200\200\002\020\254\002\030\364\003 \200\200\200\010(\0000\200\200\200 8\200\200\200\010@\2008H\000RX\010\000\020\000\030\010 \010(\200\200\200@0\377\377\377\377\0178\001B$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionJ\017compaction_gen1P\nX\200\200\001`nh\000p\000Rb\010\001\020\200\200\200\024\030\005 \020(\200\200\200\200\0020\377\377\377\377\0178\000B$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionJ\017compaction_gen2P\nX\200\200\001`nh\200\200\200\004p\200\200\200\004Rc\010\002\020\200\200\200\310\001\030\005 \020(\200\200\200\200@0\377\377\377\377\0178\000B$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionJ\017compaction_gen3P\nX\200\200\001`nh\200\200\200(p\200\200\200(X\001`\005j$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionr\017compaction_gen0z\017compaction_gen0\202\001\004scan\210\001\200\200\200\010\220\001\364\003\230\0012\270\001\2008\300\001\006R\002\020\001b\035\010\0000\000J\027\n\005\n\003ssd\022\005\n\003ssd\032\007\n\003ssd\020\000b\026\010\001\020\001*\003hdd0\001J\t\032\007\n\003hdd\020\000\212\001&\010\000\022\004\010\001\020\000\022\004\010\002\020\001\022\004\010\003\020\001\032\004\010\001\020\000\032\004\010\002\020\001\032\004\010\003\020\001\212\001\016\010\001\022\004\010\003\020\002\032\004\010\003\020\002J\022/Root/tenant/table\242\001\006\001\000\000\000\000\200\252\001\000\260\001\001\270\001\000\210\002\001\222\002\013\t\000\001\205\000\000\000\000\001\020\003:\004\010\002\020\001" TxId: 281474976715659 ExecLevel: 0 Flags: 0 SchemeShardId: 72057594046644480 ProcessingParams { Version: 2 PlanResolution: 10 Coordinators: 72075186224037888 TimeCastBucketsPerMediator: 2 Mediators: 72075186224037889 } SubDomainPathId: 2
2025-11-14T10:38:44.178987Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:44.182029Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.182090Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72075186224037890 cookie: 72057594046644480:3 msg type: 269549568
2025-11-14T10:38:44.182263Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715659, partId: 0, tablet: 72075186224037890
2025-11-14T10:38:44.332793Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [4:535:2446], Recipient [4:529:2441]: {EvTabletCreationResult Status: OK TabletID: 72075186224037890}
2025-11-14T10:38:44.354984Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1520:2940], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72075186224037890 Status: OK ServerId: [5:1570:2451] Leader: 1 Dead: 0 Generation: 1 VersionInfo:  }
2025-11-14T10:38:44.355053Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T10:38:44.355089Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037890, status: OK, at schemeshard: 72057594046644480
2025-11-14T10:38:44.382519Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269550080, Sender [5:1537:2432], Recipient [4:529:2441]
2025-11-14T10:38:44.382608Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvProposeTransactionResult
2025-11-14T10:38:44.386277Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvProposeTransactionResult, at schemeshard: 72057594046644480, message: TxKind: TX_KIND_SCHEME Origin: 72075186224037890 Status: PREPARED TxId: 281474976715659 MinStep: 1 MaxStep: 18446744073709551615 PrepareArriveTime: 1508512 ExecLatency: 0 ProposeLatency: 1 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 489 } }
2025-11-14T10:38:44.386382Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715659, tablet: 72075186224037890, partId: 0
2025-11-14T10:38:44.386639Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480, message: TxKind: TX_KIND_SCHEME Origin: 72075186224037890 Status: PREPARED TxId: 281474976715659 MinStep: 1 MaxStep: 18446744073709551615 PrepareArriveTime: 1508512 ExecLatency: 0 ProposeLatency: 1 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 489 } }
2025-11-14T10:38:44.386733Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TConfigureParts operationId# 281474976715659:0 HandleReply TEvProposeTransactionResult at tabletId# 72057594046644480
2025-11-14T10:38:44.386863Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable TConfigureParts operationId# 281474976715659:0 HandleReply TEvProposeTransactionResult message: TxKind: TX_KIND_SCHEME Origin: 72075186224037890 Status: PREPARED TxId: 281474976715659 MinStep: 1 MaxStep: 18446744073709551615 PrepareArriveTime: 1508512 ExecLatency: 0 ProposeLatency: 1 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 489 } }
2025-11-14T10:38:44.386921Z node 4 :FLAT_TX_SCHEMESHARD INFO: TEvProposeTransactionResult at tablet: 72057594046644480
2025-11-14T10:38:44.387038Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: CollectProposeTransactionResults accept TEvProposeTransactionResult, shard: 72075186224037890, shardIdx: 72057594046644480:3, operationId: 281474976715659:0, left await: 0, at schemeshard: 72057594046644480
2025-11-14T10:38:44.387084Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 3 -> 128
2025-11-14T10:38:44.387246Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:44.387310Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72075186224037890 cookie: 72057594046644480:3
2025-11-14T10:38:44.391192Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:38:44.391261Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.391329Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T10:38:44.391576Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:38:44.391624Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:38:44.391681Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:38:44.391762Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TPropose operationId# 281474976715659:0 HandleReply ProgressState at tablet: 72057594046644480
2025-11-14T10:38:44.391830Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:44.391884Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976715659 ready parts: 1/1
2025-11-14T10:38:44.392025Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoPropose send propose to coordinator: 72075186224037888 message:Transaction { AffectedSet { TabletId: 72057594046644480 Flags: 2 } AffectedSet { TabletId: 72075186224037890 Flags: 2 } ExecLevel: 0 TxId: 281474976715659 MinStep: 1 MaxStep: 18446744073709551615 IgnoreLowDiskSpace: true } CoordinatorID: 72075186224037888
2025-11-14T10:38:44.395757Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.395808Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715659:4294967295 from tablet: 72057594046644480 to tablet: 72075186224037888 cookie: 0:281474976715659 msg type: 269090816
2025-11-14T10:38:44.395907Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715659, partId: 4294967295, tablet: 72075186224037888
2025-11-14T10:38:44.396701Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [5:1382:2370], Recipient [4:529:2441]
2025-11-14T10:38:44.399705Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [5:1382:2370], Recipient [4:529:2441]
2025-11-14T10:38:44.400678Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1593:2954], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:44.400728Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:44.400757Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:38:44.401614Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [5:1465:2412], Recipient [4:1593:2954]
2025-11-14T10:38:44.401672Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-11-14T10:38:44.401755Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1560, transactions count in step: 1, at schemeshard: 72057594046644480
2025-11-14T10:38:44.401838Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPlanStep Execute, message: Transactions { TxId: 281474976715659 AckTo { RawX1: 0 RawX2: 0 } } Step: 1560 MediatorID: 72075186224037889 TabletID: 72057594046644480, at schemeshard: 72057594046644480
2025-11-14T10:38:44.401902Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TPropose operationId# 281474976715659:0 HandleReply TEvOperationPlan at tablet: 72057594046644480, stepId: 1560
2025-11-14T10:38:44.402080Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 128 -> 129
2025-11-14T10:38:44.402162Z node 4 :FLAT_TX_SCHEMESHARD TRACE: NTableState::TProposedWaitParts operationId# 281474976715659:0 Constructed
2025-11-14T10:38:44.402238Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:44.402293Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 4
2025-11-14T10:38:44.402373Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 3
2025-11-14T10:38:44.402420Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715659:4294967295 from tablet: 72057594046644480 to tablet: 0 cookie: 0:281474976715659
2025-11-14T10:38:44.411372Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.411431Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1560
2025-11-14T10:38:44.411470Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T10:38:44.411851Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:38:44.411886Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:38:44.412092Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T10:38:44.412117Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T10:38:44.412244Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 3]
2025-11-14T10:38:44.412479Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T10:38:44.412508Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 2
2025-11-14T10:38:44.412551Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 3
2025-11-14T10:38:44.412876Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:38:44.412938Z node 4 :FLAT_TX_SCHEMESHARD INFO: NTableState::TProposedWaitParts operationId# 281474976715659:0 ProgressState at tablet: 72057594046644480
2025-11-14T10:38:44.413048Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:44.414762Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 6 }
2025-11-14T10:38:44.414819Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:38:44.414904Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 6 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:38:44.414988Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 6 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:38:44.415041Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T10:38:44.415092Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 6
2025-11-14T10:38:44.415128Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T10:38:44.415193Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:44.416523Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 3] Version: 3 }
2025-11-14T10:38:44.416566Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:38:44.416620Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 3 Version: 3 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:38:44.416724Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 3 Version: 3 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:38:44.416759Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T10:38:44.416783Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], version: 3
2025-11-14T10:38:44.416817Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 4
2025-11-14T10:38:44.416915Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 0/1, is published: true
2025-11-14T10:38:44.416954Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:44.422525Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.426193Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T10:38:44.426266Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.428275Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T10:38:44.428327Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.429729Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269550080, Sender [5:1537:2432], Recipient [4:529:2441]
2025-11-14T10:38:44.429774Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvProposeTransactionResult
2025-11-14T10:38:44.429904Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvProposeTransactionResult, at schemeshard: 72057594046644480, message: TxKind: TX_KIND_SCHEME Origin: 72075186224037890 Status: COMPLETE TxId: 281474976715659 Step: 1560 OrderId: 281474976715659 ExecLatency: 0 ProposeLatency: 7 DomainCoordinators: 72075186224037888 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 1975 } }
2025-11-14T10:38:44.429928Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715659, tablet: 72075186224037890, partId: 0
2025-11-14T10:38:44.430029Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480, message: TxKind: TX_KIND_SCHEME Origin: 72075186224037890 Status: COMPLETE TxId: 281474976715659 Step: 1560 OrderId: 281474976715659 ExecLatency: 0 ProposeLatency: 7 DomainCoordinators: 72075186224037888 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 1975 } }
2025-11-14T10:38:44.430124Z node 4 :FLAT_TX_SCHEMESHARD INFO: HandleReply TEvDataShard::TEvProposeTransactionResult Ignore message: tablet# 72057594046644480, ev# TxKind: TX_KIND_SCHEME Origin: 72075186224037890 Status: COMPLETE TxId: 281474976715659 Step: 1560 OrderId: 281474976715659 ExecLatency: 0 ProposeLatency: 7 DomainCoordinators: 72075186224037888 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 1975 } }
2025-11-14T10:38:44.430166Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:44.432450Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1626:2972], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:44.432498Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:44.432527Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:38:44.433402Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:38:44.433444Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.434082Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269551620, Sender [5:1537:2432], Recipient [4:1626:2972]
2025-11-14T10:38:44.434130Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvSchemaChanged
2025-11-14T10:38:44.434354Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvSchemaChanged, tabletId: 72057594046644480, at schemeshard: 72057594046644480, message: Source { RawX1: 1537 RawX2: 21474838912 } Origin: 72075186224037890 State: 2 TxId: 281474976715659 Step: 0 Generation: 1
2025-11-14T10:38:44.434418Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715659, tablet: 72075186224037890, partId: 0
2025-11-14T10:38:44.434630Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvSchemaChanged> execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480, message: Source { RawX1: 1537 RawX2: 21474838912 } Origin: 72075186224037890 State: 2 TxId: 281474976715659 Step: 0 Generation: 1
2025-11-14T10:38:44.434732Z node 4 :FLAT_TX_SCHEMESHARD INFO: NTableState::TProposedWaitParts operationId# 281474976715659:0 HandleReply TEvDataShard::TEvSchemaChanged at tablet: 72057594046644480
2025-11-14T10:38:44.434873Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NTableState::TProposedWaitParts operationId# 281474976715659:0 HandleReply TEvDataShard::TEvSchemaChanged at tablet: 72057594046644480 message: Source { RawX1: 1537 RawX2: 21474838912 } Origin: 72075186224037890 State: 2 TxId: 281474976715659 Step: 0 Generation: 1
2025-11-14T10:38:44.434973Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: CollectSchemaChanged accept TEvDataShard::TEvSchemaChanged, operationId: 281474976715659:0, shardIdx: 72057594046644480:3, shard: 72075186224037890, left await: 0, txState.State: ProposedWaitParts, txState.ReadyForNotifications: 1, at schemeshard: 72057594046644480
2025-11-14T10:38:44.435026Z node 4 :FLAT_TX_SCHEMESHARD INFO: all shard schema changes has been received, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:38:44.435096Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: send schema changes ack message, operation: 281474976715659:0, datashard: 72075186224037890, at schemeshard: 72057594046644480
2025-11-14T10:38:44.435158Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 129 -> 240
2025-11-14T10:38:44.435368Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:44.438150Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvSchemaChanged> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:38:44.438212Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.438266Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T10:38:44.438389Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [5:1537:2432] msg type: 269552132 msg: NKikimrTxDataShard.TEvSchemaChangedResult TxId: 281474976715659 at schemeshard: 72057594046644480
2025-11-14T10:38:44.438646Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:38:44.438703Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:38:44.438764Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:38:44.438821Z node 4 :FLAT_TX_SCHEMESHARD INFO: [72057594046644480] TDone opId# 281474976715659:0 ProgressState
2025-11-14T10:38:44.438965Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:38:44.439011Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715659:0 progress is 1/1
2025-11-14T10:38:44.439075Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715659 ready parts: 1/1
2025-11-14T10:38:44.439143Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715659:0 progress is 1/1
2025-11-14T10:38:44.439191Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715659 ready parts: 1/1
2025-11-14T10:38:44.439247Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 1/1, is published: true
2025-11-14T10:38:44.439342Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoNotify send TEvNotifyTxCompletionResult to actorId: [4:1292:2838] message: TxId: 281474976715659
2025-11-14T10:38:44.439418Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715659 ready parts: 1/1
2025-11-14T10:38:44.439491Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976715659:0
2025-11-14T10:38:44.439551Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976715659:0
2025-11-14T10:38:44.439724Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 3
2025-11-14T10:38:44.442699Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.442831Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [4:1292:2838] msg type: 271124998 msg: NKikimrScheme.TEvNotifyTxCompletionResult TxId: 281474976715659 at schemeshard: 72057594046644480
2025-11-14T10:38:44.443321Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1332:2853], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:38:44.443369Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:38:44.443396Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T10:38:44.549949Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715660. Ctx: { TraceId: 01ka0z4c71bntetmpp1cdr3hv8, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=YWViZjk4MzAtMjExMmUwMmYtYTRlNmQ0NjktNGVhNDM1NTA=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-11-14T10:38:44.573980Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1626:2972], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:38:44.574080Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:38:44.574133Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T10:38:44.576711Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1657:2995], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:44.576793Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:44.576845Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:38:44.577081Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122945, Sender [4:1654:2992], Recipient [4:529:2441]: NKikimrSchemeOp.TDescribePath Path: "/Root/tenant/table" Options { ShowPrivateTable: true }
2025-11-14T10:38:44.577112Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvDescribeScheme
2025-11-14T10:38:44.638311Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1675:3002], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:44.638385Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:38:44.638432Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:38:44.639186Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [5:1537:2432], Recipient [4:1675:3002]
2025-11-14T10:38:44.639246Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-11-14T10:38:44.639345Z node 4 :FLAT_TX_SCHEMESHARD INFO: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] state 'Ready' dataSize 75 rowCount 1 cpuUsage 0
2025-11-14T10:38:44.639547Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] raw table stats:
DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1524 LastUpdateTime: 1524 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0
2025-11-14T10:38:44.639616Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.100000s, queue# 1
2025-11-14T10:38:44.761041Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T10:38:44.761139Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T10:38:44.761185Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 1
2025-11-14T10:38:44.761255Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 1
2025-11-14T10:38:44.761318Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.000000s, queue# 1
2025-11-14T10:38:44.761444Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: PersistSingleStats for pathId 3 shard idx 72057594046644480:3 data size 75 row count 1
2025-11-14T10:38:44.761545Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxStoreTableStats.PersistSingleStats: main stats from datashardId(TabletID)=72075186224037890 maps to shardIdx: 72057594046644480:3 followerId=0, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], pathId map=table, is column=0, is olap=0
2025-11-14T10:38:44.761610Z node 4 :FLAT_TX_SCHEMESHARD INFO: Add stats from shard with datashardId(TabletID)=72075186224037890 followerId=0, pathId 3: RowCount 1, DataSize 75
2025-11-14T10:38:44.761655Z node 4 :FLAT_TX_SCHEMESHARD TRACE: BuildStatsForCollector: datashardId 72075186224037890, followerId 0
2025-11-14T10:38:44.761762Z node 4 :FLAT_TX_SCHEMESHARD TRACE: [BackgroundCompaction] [Update] Skipped shard# 72057594046644480:3 with partCount# 1, rowCount# 1, searchHeight# 1, lastFullCompaction# 1970-01-01T00:00:01.000000Z at schemeshard 72057594046644480
2025-11-14T10:38:44.762206Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T10:38:44.762276Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 0, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T10:38:44.767637Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:44.767721Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T10:38:44.767772Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 0, path id: 2
2025-11-14T10:38:44.768773Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 7 }
2025-11-14T10:38:44.768826Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:38:44.768924Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 7 PathOwnerId: 72057594046644480, cookie: 0
2025-11-14T10:38:44.784229Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T10:38:44.784295Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T10:38:44.784325Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-11-14T10:38:44.997710Z node 5 :TX_CONVEYOR ERROR: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-11-14T10:38:45.092611Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:45.092724Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:45.092856Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:45.092894Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:45.763931Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:45.764010Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:45.764113Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:45.764154Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:46.301261Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:46.301332Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:46.301422Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:46.301451Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:46.840444Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:46.840520Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:46.840631Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:46.840685Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:47.445667Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:47.445752Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:47.445857Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:47.445891Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
Captured TEvDataShard::TEvPeriodicTableStats DatashardId: 72075186224037890 TableLocalId: 3 Generation: 1 Round: 1 TableStats { DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1524 LastUpdateTime: 1524 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0 } TabletMetrics { Memory: 82472 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1458 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T10:38:47.662686Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [5:1537:2432], Recipient [4:529:2441]: NKikimrTxDataShard.TEvPeriodicTableStats DatashardId: 72075186224037890 TableLocalId: 3 Generation: 1 Round: 1 TableStats { DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1524 LastUpdateTime: 1524 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0 } TabletMetrics { Memory: 82472 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1458 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T10:38:47.662755Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-11-14T10:38:47.662832Z node 4 :FLAT_TX_SCHEMESHARD INFO: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] state 'Ready' dataSize 75 rowCount 1 cpuUsage 0
2025-11-14T10:38:47.663002Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] raw table stats:
DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1524 LastUpdateTime: 1524 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0
2025-11-14T10:38:47.663059Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.100000s, queue# 1
2025-11-14T10:38:47.759632Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715661. Ctx: { TraceId: 01ka0z4fbk1dxg9pvrcyjz010y, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=NjBhOGMzZGYtYWY4ZDAxNjUtMTJmNmI5Y2ItOGJiZjMwMjQ=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-11-14T10:38:47.760878Z node 5 :TX_DATASHARD ERROR: Cannot perform writes: database is out of disk space
2025-11-14T10:38:47.760962Z node 5 :TX_DATASHARD ERROR: Prepare transaction failed. txid 281474976715661 at tablet 72075186224037890 errors: DISK_SPACE_EXHAUSTED (Cannot perform writes: database is out of disk space) |
2025-11-14T10:38:47.761056Z node 5 :TX_DATASHARD ERROR: Errors while proposing transaction txid 281474976715661 at tablet 72075186224037890 status: ERROR errors: DISK_SPACE_EXHAUSTED (Cannot perform writes: database is out of disk space) |
2025-11-14T10:38:47.761625Z node 4 :KQP_EXECUTER ERROR: ActorId: [4:1831:3106] TxId: 281474976715661. Ctx: { TraceId: 01ka0z4fbk1dxg9pvrcyjz010y, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=NjBhOGMzZGYtYWY4ZDAxNjUtMTJmNmI5Y2ItOGJiZjMwMjQ=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. ERROR: [DISK_SPACE_EXHAUSTED] Cannot perform writes: database is out of disk space; 
2025-11-14T10:38:47.772396Z node 4 :KQP_SESSION WARN: SessionId: ydb://session/3?node_id=4&id=NjBhOGMzZGYtYWY4ZDAxNjUtMTJmNmI5Y2ItOGJiZjMwMjQ=, ActorId: [4:1821:3106], ActorState: ExecuteState, TraceId: 01ka0z4fbk1dxg9pvrcyjz010y, Create QueryResponse for error on request, msg: 
2025-11-14T10:38:47.773568Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715662. Ctx: { TraceId: 01ka0z4fbk1dxg9pvrcyjz010y, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=NjBhOGMzZGYtYWY4ZDAxNjUtMTJmNmI5Y2ItOGJiZjMwMjQ=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-11-14T10:38:47.853891Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T10:38:47.854016Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T10:38:47.854072Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 1
2025-11-14T10:38:47.854168Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 1
2025-11-14T10:38:47.854220Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.000000s, queue# 1
2025-11-14T10:38:47.854424Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: PersistSingleStats for pathId 3 shard idx 72057594046644480:3 data size 75 row count 1
2025-11-14T10:38:47.854529Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxStoreTableStats.PersistSingleStats: main stats from datashardId(TabletID)=72075186224037890 maps to shardIdx: 72057594046644480:3 followerId=0, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], pathId map=table, is column=0, is olap=0
2025-11-14T10:38:47.854609Z node 4 :FLAT_TX_SCHEMESHARD INFO: Add stats from shard with datashardId(TabletID)=72075186224037890 followerId=0, pathId 3: RowCount 1, DataSize 75
2025-11-14T10:38:47.854696Z node 4 :FLAT_TX_SCHEMESHARD TRACE: BuildStatsForCollector: datashardId 72075186224037890, followerId 0
2025-11-14T10:38:47.854813Z node 4 :FLAT_TX_SCHEMESHARD TRACE: [BackgroundCompaction] [Update] Skipped shard# 72057594046644480:3 with partCount# 1, rowCount# 1, searchHeight# 1, lastFullCompaction# 1970-01-01T00:00:01.000000Z at schemeshard 72057594046644480
2025-11-14T10:38:47.855420Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T10:38:47.855478Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 0, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T10:38:47.861932Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:38:47.862033Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T10:38:47.862088Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 0, path id: 2
2025-11-14T10:38:47.863165Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 8 }
2025-11-14T10:38:47.863218Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:38:47.863355Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 8 PathOwnerId: 72057594046644480, cookie: 0
2025-11-14T10:38:47.877034Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T10:38:47.877105Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T10:38:47.877136Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-11-14T10:38:48.144372Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:48.144481Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:48.144611Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:48.144666Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:48.861691Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:48.861777Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:48.861878Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:48.861910Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:49.603087Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:49.603171Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:49.603276Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:49.603305Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:50.376845Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:50.376897Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:50.376989Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:50.377013Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:51.171289Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:51.171352Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:38:51.171435Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:38:51.171464Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
Captured TEvDataShard::TEvPeriodicTableStats DatashardId: 72075186224037890 TableLocalId: 3 Generation: 1 Round: 2 TableStats { DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1524 LastUpdateTime: 1524 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 1 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0 } TabletMetrics { Memory: 82472 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1458 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T10:38:51.468146Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [5:1537:2432], Recipient [4:529:2441]: NKikimrTxDataShard.TEvPeriodicTableStats DatashardId: 72075186224037890 TableLocalId: 3 Generation: 1 Round: 2 TableStats { DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1524 LastUpdateTime: 1524 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 1 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0 } TabletMetrics { Memory: 82472 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1458 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T10:38:51.468213Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-11-14T10:38:51.468279Z node 4 :FLAT_TX_SCHEMESHARD INFO: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] state 'Ready' dataSize 75 rowCount 1 cpuUsage 0
2025-11-14T10:38:51.468425Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] raw table stats:
DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1524 LastUpdateTime: 1524 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 1 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0
2025-11-14T10:38:51.468490Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.100000s, queue# 1
2025-11-14T10:38:51.534305Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715663. Ctx: { TraceId: 01ka0z4k2g2qrhg56ar6pd3dsj, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=YTNjZWU0NjEtMjViMjI2NmEtYWFlNzcwMTMtNTYzOThmYzQ=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
