2025-11-14T08:14:33.036036Z 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/2be8/0035bc/r3tmp/tmpcd7vPm/pdisk_1.dat
2025-11-14T08:14:33.214136Z 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-14T08:14:33.267953Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-14T08:14:33.267983Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-14T08:14:33.279545Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-11-14T08:14:33.549064Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:966:2780], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:33.549089Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:33.549094Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:14:33.549111Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [4:963:2778], Recipient [4:543:2450]: {TEvModifySchemeTransaction txid# 281474976715657 TabletId# 72057594046644480}
2025-11-14T08:14:33.549116Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-11-14T08:14:33.558384Z 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-14T08:14:33.558476Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TCreateSubDomain Propose, path: /Root/tenant, opId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T08:14:33.558502Z 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-14T08:14:33.558552Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 0
2025-11-14T08:14:33.558595Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason  for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 1
2025-11-14T08:14:33.558623Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976715657:1, propose status:StatusAccepted, reason: , at schemeshard: 72057594046644480
2025-11-14T08:14:33.558630Z 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-14T08:14:33.558640Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:33.558652Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 1
2025-11-14T08:14:33.558661Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T08:14:33.559473Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976715657, response: Status: StatusAccepted TxId: 281474976715657 SchemeshardId: 72057594046644480 PathId: 2, at schemeshard: 72057594046644480
2025-11-14T08:14:33.559519Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976715657, database: /Root, subject: , status: StatusAccepted, operation: CREATE DATABASE, path: /Root/tenant
2025-11-14T08:14:33.559527Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:33.559532Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T08:14:33.559605Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:14:33.559613Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:14:33.559649Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T08:14:33.559654Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 1]
2025-11-14T08:14:33.559713Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T08:14:33.559732Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T08:14:33.559737Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 1
2025-11-14T08:14:33.559742Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 2
2025-11-14T08:14:33.559836Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T08:14:33.559845Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715657:0 ProgressState, operation type: TxCreateSubDomain, at tablet# 72057594046644480
2025-11-14T08:14:33.559849Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715657:0 ProgressState no shards to create, do next state
2025-11-14T08:14:33.559855Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715657:0 2 -> 3
2025-11-14T08:14:33.559874Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:33.559955Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:966:2780], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:14:33.559962Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:14:33.559966Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T08:14:33.560306Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 1] Version: 4 }
2025-11-14T08:14:33.560319Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:14:33.560330Z 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-14T08:14:33.560341Z 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-14T08:14:33.560344Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T08:14:33.560348Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 1], version: 4
2025-11-14T08:14:33.560352Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 2
2025-11-14T08:14:33.560367Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:33.560526Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 2 }
2025-11-14T08:14:33.560533Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:14:33.560542Z 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-14T08:14:33.560554Z 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-14T08:14:33.560558Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T08:14:33.560562Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 2
2025-11-14T08:14:33.560567Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 3
2025-11-14T08:14:33.560579Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715657, ready parts: 0/1, is published: true
2025-11-14T08:14:33.560583Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:33.561165Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:33.561178Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T08:14:33.561222Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:14:33.561229Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:14:33.561237Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T08:14:33.561246Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715657:0 ProgressState, at schemeshard: 72057594046644480
2025-11-14T08:14:33.561253Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715657:0 3 -> 128
2025-11-14T08:14:33.561265Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:33.561348Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T08:14:33.561352Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:33.561665Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T08:14:33.561674Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:33.561908Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:33.561915Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T08:14:33.561934Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:14:33.561938Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:14:33.561945Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T08:14:33.561950Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose ProgressState, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T08:14:33.561956Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose ProgressState leave, operationId 281474976715657:0, at tablet# 72057594046644480
2025-11-14T08:14:33.561960Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:33.561969Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976715657 ready parts: 1/1
2025-11-14T08:14:33.562595Z 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-14T08:14:33.563004Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:33.563017Z 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-14T08:14:33.563039Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715657, partId: 4294967295, tablet: 72057594046316545
2025-11-14T08:14:33.563088Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:536:2446], Recipient [4:543:2450]: NKikimrTx.TEvProposeTransactionStatus Status: 16 StepId: 1000 TxId: 281474976715657
2025-11-14T08:14:33.563166Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:986:2800], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:33.563172Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:33.563176Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:14:33.563196Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124996, Sender [4:906:2727], Recipient [4:543:2450]: NKikimrScheme.TEvNotifyTxCompletion TxId: 281474976715657
2025-11-14T08:14:33.563201Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvNotifyTxCompletion
2025-11-14T08:14:33.563209Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NotifyTxCompletion operation in-flight, txId: 281474976715657, at schemeshard: 72057594046644480
2025-11-14T08:14:33.563213Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715657, ready parts: 0/1, is published: true
2025-11-14T08:14:33.563218Z node 4 :FLAT_TX_SCHEMESHARD INFO: NotifyTxCompletion transaction is registered, txId: 281474976715657, at schemeshard: 72057594046644480
2025-11-14T08:14:33.880964Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:536:2446], Recipient [4:543:2450]: NKikimrTx.TEvProposeTransactionStatus Status: 17 StepId: 1000 TxId: 281474976715657
2025-11-14T08:14:33.881078Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [4:755:2601], Recipient [4:543:2450]: {TEvPlanStep step# 1000 MediatorId# 72057594046382081 TabletID 72057594046644480}
2025-11-14T08:14:33.881086Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-11-14T08:14:33.881099Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1000, transactions count in step: 1, at schemeshard: 72057594046644480
2025-11-14T08:14:33.881128Z 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-14T08:14:33.881138Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715657:0, at tablet# 72057594046644480
2025-11-14T08:14:33.881190Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715657:0 128 -> 240
2025-11-14T08:14:33.881199Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715657:0, at tablet# 72057594046644480
2025-11-14T08:14:33.881222Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:33.881236Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 1
2025-11-14T08:14:33.881246Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T08:14:33.881254Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715657:4294967295 from tablet: 72057594046644480 to tablet: 0 cookie: 0:281474976715657
2025-11-14T08:14:33.881260Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DoUpdateTenant no IsExternalSubDomainRoot, pathId: : [OwnerId: 72057594046644480, LocalPathId: 2], at schemeshard: 72057594046644480
2025-11-14T08:14:33.881744Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:33.881755Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1000
2025-11-14T08:14:33.881762Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T08:14:33.881819Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:14:33.881825Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:14:33.881881Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T08:14:33.881888Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 1]
2025-11-14T08:14:33.881934Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T08:14:33.881950Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T08:14:33.881955Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 1
2025-11-14T08:14:33.881960Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 2
2025-11-14T08:14:33.881988Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T08:14:33.881999Z node 4 :FLAT_TX_SCHEMESHARD INFO: [72057594046644480] TDone opId# 281474976715657:0 ProgressState
2025-11-14T08:14:33.882009Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:33.882016Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715657:0 progress is 1/1
2025-11-14T08:14:33.882020Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715657 ready parts: 1/1
2025-11-14T08:14:33.882025Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715657:0 progress is 1/1
2025-11-14T08:14:33.882028Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715657 ready parts: 1/1
2025-11-14T08:14:33.882032Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715657, ready parts: 1/1, is published: false
2025-11-14T08:14:33.882052Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715657 ready parts: 1/1
2025-11-14T08:14:33.882057Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976715657:0
2025-11-14T08:14:33.882061Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976715657:0
2025-11-14T08:14:33.882073Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 3
2025-11-14T08:14:33.882079Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication still in progress, tx: 281474976715657, publications: 2, subscribers: 1
2025-11-14T08:14:33.882083Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Publication details:  tx: 281474976715657, [OwnerId: 72057594046644480, LocalPathId: 1], 5
2025-11-14T08:14:33.882086Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Publication details:  tx: 281474976715657, [OwnerId: 72057594046644480, LocalPathId: 2], 3
2025-11-14T08:14:33.882428Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 1] Version: 5 }
2025-11-14T08:14:33.882439Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:14:33.882455Z 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-14T08:14:33.882467Z 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-14T08:14:33.882472Z node 4 :FLAT_TX_SCHEMESHARD INFO: Publication in-flight, count: 2, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T08:14:33.882477Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 1], version: 5
2025-11-14T08:14:33.882481Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 2
2025-11-14T08:14:33.882499Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:33.882814Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 3 }
2025-11-14T08:14:33.882823Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:14:33.882834Z 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-14T08:14:33.882848Z 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-14T08:14:33.882852Z node 4 :FLAT_TX_SCHEMESHARD INFO: Publication in-flight, count: 1, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T08:14:33.882856Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 3
2025-11-14T08:14:33.882860Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T08:14:33.882874Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication complete, notify & remove, at schemeshard: 72057594046644480, txId: 281474976715657, subscribers: 1
2025-11-14T08:14:33.882879Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Notify send TEvNotifyTxCompletionResult, at schemeshard: 72057594046644480, to actorId: [4:906:2727]
2025-11-14T08:14:33.882885Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:33.883399Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:33.883809Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T08:14:33.883819Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:33.883840Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T08:14:33.883843Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:33.883856Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [4:906:2727] msg type: 271124998 msg: NKikimrScheme.TEvNotifyTxCompletionResult TxId: 281474976715657 at schemeshard: 72057594046644480
2025-11-14T08:14:33.884346Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1018:2825], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:33.884355Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:33.884358Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:14:33.884374Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [4:1008:2822], Recipient [4:543:2450]: {TEvModifySchemeTransaction txid# 281474976715658 TabletId# 72057594046644480}
2025-11-14T08:14:33.884377Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-11-14T08:14:33.885117Z 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-14T08:14:33.885150Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TAlterSubDomain Propose, path: /Root/tenant, opId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:14:33.885191Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 1
2025-11-14T08:14:33.885198Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T08:14:33.885202Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 3
2025-11-14T08:14:33.885257Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976715658:1, propose status:StatusAccepted, reason: , at schemeshard: 72057594046644480
2025-11-14T08:14:33.885262Z 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-14T08:14:33.885270Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:33.885725Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976715658, response: Status: StatusAccepted TxId: 281474976715658 SchemeshardId: 72057594046644480 PathId: 2, at schemeshard: 72057594046644480
2025-11-14T08:14:33.885746Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976715658, database: /Root, subject: , status: StatusAccepted, operation: ALTER DATABASE, path: /Root/tenant
2025-11-14T08:14:33.885750Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:33.885754Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T08:14:33.885793Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:14:33.885798Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:14:33.885806Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:14:33.885814Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715658:0 ProgressState, operation type: TxAlterSubDomain, at tablet# 72057594046644480
2025-11-14T08:14:33.885863Z 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-14T08:14:33.885875Z 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-14T08:14:33.885879Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:33.885931Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1018:2825], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:14:33.885935Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:14:33.885937Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T08:14:33.886243Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:33.886252Z 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-14T08:14:33.886276Z 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-14T08:14:33.886300Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 0, tablet: 72057594037968897
2025-11-14T08:14:33.886308Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:1, partId: 0
2025-11-14T08:14:33.886313Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:2, partId: 0
2025-11-14T08:14:33.886395Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1025:2832], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72057594037968897 Status: OK ServerId: [4:1026:2833] Leader: 1 Dead: 0 Generation: 2 VersionInfo:  }
2025-11-14T08:14:33.886399Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T08:14:33.886402Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72057594037968897, status: OK, at schemeshard: 72057594046644480
2025-11-14T08:14:34.146961Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1302:2847], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:34.146977Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:34.146981Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:14:34.147456Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122945, Sender [5:1264:2343], Recipient [4:1302:2847]
2025-11-14T08:14:34.147466Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvDescribeScheme
2025-11-14T08:14:34.149284Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1327:2853], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:34.149297Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:34.149300Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:14:34.149332Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [4:1298:2844], Recipient [4:543:2450]: {TEvModifySchemeTransaction txid# 281474976715659 TabletId# 72057594046644480}
2025-11-14T08:14:34.149335Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-11-14T08:14:34.149852Z 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-14T08:14:34.149906Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TCreateTable Propose, path: /Root/tenant/table, opId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.149922Z 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-14T08:14:34.150012Z 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-14T08:14:34.150023Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 0
2025-11-14T08:14:34.150028Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 1
2025-11-14T08:14:34.150044Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new path created for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 2
2025-11-14T08:14:34.150048Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 1 -> 2
2025-11-14T08:14:34.150167Z 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-14T08:14:34.150179Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976715659:1, propose status:StatusAccepted, reason: , at schemeshard: 72057594046644480
2025-11-14T08:14:34.150186Z 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-14T08:14:34.150195Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.150201Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T08:14:34.150207Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 3
2025-11-14T08:14:34.150879Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976715659, response: Status: StatusAccepted TxId: 281474976715659 SchemeshardId: 72057594046644480 PathId: 3, at schemeshard: 72057594046644480
2025-11-14T08:14:34.150913Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976715659, database: /Root/tenant, subject: , status: StatusAccepted, operation: CREATE TABLE, path: /Root/tenant/table
2025-11-14T08:14:34.150920Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.150926Z node 4 :FLAT_TX_SCHEMESHARD INFO: Delay activating, operation part: 281474976715659:0, there is await operations num 1
2025-11-14T08:14:34.150967Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T08:14:34.150973Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T08:14:34.151000Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 3]
2025-11-14T08:14:34.151011Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T08:14:34.151015Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 2
2025-11-14T08:14:34.151018Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 3
2025-11-14T08:14:34.151218Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1327:2853], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:14:34.151224Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:14:34.151230Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T08:14:34.151293Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 4 }
2025-11-14T08:14:34.151297Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:14:34.151307Z 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-14T08:14:34.151314Z 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-14T08:14:34.151316Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T08:14:34.151319Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 4
2025-11-14T08:14:34.151322Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 6
2025-11-14T08:14:34.151336Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.151424Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1337:2858], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:34.151429Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:34.151433Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:14:34.151474Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 3] Version: 1 }
2025-11-14T08:14:34.151477Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:14:34.151483Z 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-14T08:14:34.151489Z 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-14T08:14:34.151492Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T08:14:34.151494Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], version: 1
2025-11-14T08:14:34.151496Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 4
2025-11-14T08:14:34.151504Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 0/1, is published: true
2025-11-14T08:14:34.151506Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.151562Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124996, Sender [4:1297:2843], Recipient [4:543:2450]: NKikimrScheme.TEvNotifyTxCompletion TxId: 281474976715659
2025-11-14T08:14:34.151570Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvNotifyTxCompletion
2025-11-14T08:14:34.151575Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NotifyTxCompletion operation in-flight, txId: 281474976715659, at schemeshard: 72057594046644480
2025-11-14T08:14:34.151577Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 0/1, is published: true
2025-11-14T08:14:34.151581Z node 4 :FLAT_TX_SCHEMESHARD INFO: NotifyTxCompletion transaction is registered, txId: 281474976715659, at schemeshard: 72057594046644480
2025-11-14T08:14:34.152171Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T08:14:34.152182Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.152301Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T08:14:34.152305Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.152543Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(5, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-14T08:14:34.152560Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(5, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-14T08:14:34.184211Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [4:546:2452], Recipient [4:543:2450]: {EvCreateTabletReply Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897}
2025-11-14T08:14:34.184233Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-11-14T08:14:34.184262Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72057594046644480 message: Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897
2025-11-14T08:14:34.184273Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:1, partId: 0
2025-11-14T08:14:34.184299Z 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-14T08:14:34.184308Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, at tabletId: 72057594046644480
2025-11-14T08:14:34.184315Z 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-14T08:14:34.184348Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.184355Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:1
2025-11-14T08:14:34.184438Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [4:546:2452], Recipient [4:543:2450]: {EvCreateTabletReply Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897}
2025-11-14T08:14:34.184441Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-11-14T08:14:34.184446Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72057594046644480 message: Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897
2025-11-14T08:14:34.184449Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:2, partId: 0
2025-11-14T08:14:34.184458Z 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-14T08:14:34.184461Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, at tabletId: 72057594046644480
2025-11-14T08:14:34.184465Z 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-14T08:14:34.184472Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715658:0 2 -> 3
2025-11-14T08:14:34.184485Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.184487Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:2
2025-11-14T08:14:34.184510Z node 4 :HIVE WARN: HIVE#72057594037968897 Handle TEvInterconnect::TEvNodeConnected, NodeId 5 Cookie 5
2025-11-14T08:14:34.185085Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(5, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-11-14T08:14:34.185385Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.185395Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.185640Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.185647Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.185652Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T08:14:34.185678Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.185684Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.185692Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.185699Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715658:0 ProgressState, at schemeshard: 72057594046644480
2025-11-14T08:14:34.185718Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send configure request to coordinator/mediator: 72075186224037888 opId: 281474976715658:0 schemeshard: 72057594046644480
2025-11-14T08:14:34.185725Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send configure request to coordinator/mediator: 72075186224037889 opId: 281474976715658:0 schemeshard: 72057594046644480
2025-11-14T08:14:34.185732Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.186136Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.186149Z 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-14T08:14:34.186173Z 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-14T08:14:34.186190Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 0, tablet: 72075186224037888
2025-11-14T08:14:34.186198Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 0, tablet: 72075186224037889
2025-11-14T08:14:34.240059Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [4:546:2452], Recipient [4:543:2450]: {EvTabletCreationResult Status: OK TabletID: 72075186224037888}
2025-11-14T08:14:34.240089Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [4:546:2452], Recipient [4:543:2450]: {EvTabletCreationResult Status: OK TabletID: 72075186224037889}
2025-11-14T08:14:34.281695Z node 4 :TX_CONVEYOR ERROR: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-11-14T08:14:34.292691Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1356:2877], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72075186224037888 Status: OK ServerId: [5:1451:2401] Leader: 1 Dead: 0 Generation: 1 VersionInfo:  }
2025-11-14T08:14:34.292712Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T08:14:34.292718Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037888, status: OK, at schemeshard: 72057594046644480
2025-11-14T08:14:34.292733Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:34.292737Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:34.292916Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1357:2878], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72075186224037889 Status: OK ServerId: [5:1452:2402] Leader: 1 Dead: 0 Generation: 1 VersionInfo:  }
2025-11-14T08:14:34.292921Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T08:14:34.292924Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037889, status: OK, at schemeshard: 72057594046644480
2025-11-14T08:14:34.294236Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 272564225, Sender [5:1387:2370], Recipient [4:543:2450]
2025-11-14T08:14:34.294251Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSubDomain::TEvConfigureStatus
2025-11-14T08:14:34.294276Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715658, tablet: 72075186224037888, partId: 0
2025-11-14T08:14:34.294343Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: SUCCESS OnTabletId: 72075186224037888
2025-11-14T08:14:34.294357Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715658:0 HandleReply TEvConfigureStatus operationId:281474976715658:0 at schemeshard:72057594046644480
2025-11-14T08:14:34.294365Z 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-14T08:14:34.294370Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.294374Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037888 cookie: 72057594046644480:1
2025-11-14T08:14:34.294538Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 272564225, Sender [5:1389:2371], Recipient [4:543:2450]
2025-11-14T08:14:34.294542Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSubDomain::TEvConfigureStatus
2025-11-14T08:14:34.294546Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715658, tablet: 72075186224037889, partId: 0
2025-11-14T08:14:34.294554Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: SUCCESS OnTabletId: 72075186224037889
2025-11-14T08:14:34.294559Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715658:0 HandleReply TEvConfigureStatus operationId:281474976715658:0 at schemeshard:72057594046644480
2025-11-14T08:14:34.294562Z 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-14T08:14:34.294566Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715658:0 3 -> 128
2025-11-14T08:14:34.294578Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.294581Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037889 cookie: 72057594046644480:2
2025-11-14T08:14:34.295066Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.295074Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.295979Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.295989Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.295993Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T08:14:34.296021Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.296026Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.296032Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.296037Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose ProgressState, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.296042Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose ProgressState leave, operationId 281474976715658:0, at tablet# 72057594046644480
2025-11-14T08:14:34.296044Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.296049Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976715658 ready parts: 1/1
2025-11-14T08:14:34.296083Z 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-14T08:14:34.296773Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.296786Z 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-14T08:14:34.296804Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 4294967295, tablet: 72057594046316545
2025-11-14T08:14:34.296851Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:536:2446], Recipient [4:543:2450]: NKikimrTx.TEvProposeTransactionStatus Status: 16 StepId: 1500 TxId: 281474976715658
2025-11-14T08:14:34.585822Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:536:2446], Recipient [4:543:2450]: NKikimrTx.TEvProposeTransactionStatus Status: 17 StepId: 1500 TxId: 281474976715658
2025-11-14T08:14:34.585912Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [4:755:2601], Recipient [4:543:2450]: {TEvPlanStep step# 1500 MediatorId# 72057594046382081 TabletID 72057594046644480}
2025-11-14T08:14:34.585918Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-11-14T08:14:34.585934Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1500, transactions count in step: 1, at schemeshard: 72057594046644480
2025-11-14T08:14:34.585952Z 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-14T08:14:34.585962Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715658:0, at tablet# 72057594046644480
2025-11-14T08:14:34.586021Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715658:0 128 -> 240
2025-11-14T08:14:34.586042Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715658:0, at tablet# 72057594046644480
2025-11-14T08:14:34.586060Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.586070Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T08:14:34.586079Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:4294967295 from tablet: 72057594046644480 to tablet: 0 cookie: 0:281474976715658
2025-11-14T08:14:34.586082Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DoUpdateTenant no IsExternalSubDomainRoot, pathId: : [OwnerId: 72057594046644480, LocalPathId: 2], at schemeshard: 72057594046644480
2025-11-14T08:14:34.586486Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.586494Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1500
2025-11-14T08:14:34.586500Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T08:14:34.586541Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.586545Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.586585Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T08:14:34.586589Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715658, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T08:14:34.586623Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T08:14:34.586626Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715658, path id: 2
2025-11-14T08:14:34.586711Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.586717Z node 4 :FLAT_TX_SCHEMESHARD INFO: [72057594046644480] TDone opId# 281474976715658:0 ProgressState
2025-11-14T08:14:34.586724Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.586729Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715658:0 progress is 1/1
2025-11-14T08:14:34.586733Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715658 ready parts: 1/1
2025-11-14T08:14:34.586741Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715658:0 progress is 1/1
2025-11-14T08:14:34.586744Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715658 ready parts: 1/1
2025-11-14T08:14:34.586749Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715658, ready parts: 1/1, is published: false
2025-11-14T08:14:34.586754Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715658 ready parts: 1/1
2025-11-14T08:14:34.586759Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Remove dependency, parent tx: 281474976715658, dependent tx: 281474976715659
2025-11-14T08:14:34.586770Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976715658:0
2025-11-14T08:14:34.586775Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976715658:0
2025-11-14T08:14:34.586794Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 6
2025-11-14T08:14:34.586803Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication still in progress, tx: 281474976715658, publications: 1, subscribers: 0
2025-11-14T08:14:34.586806Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Publication details:  tx: 281474976715658, [OwnerId: 72057594046644480, LocalPathId: 2], 5
2025-11-14T08:14:34.586903Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 5 }
2025-11-14T08:14:34.586908Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:14:34.586918Z 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-14T08:14:34.586926Z 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-14T08:14:34.586929Z node 4 :FLAT_TX_SCHEMESHARD INFO: Publication in-flight, count: 1, at schemeshard: 72057594046644480, txId: 281474976715658
2025-11-14T08:14:34.586932Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715658, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 5
2025-11-14T08:14:34.586935Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T08:14:34.586943Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication complete, notify & remove, at schemeshard: 72057594046644480, txId: 281474976715658, subscribers: 0
2025-11-14T08:14:34.586945Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.587668Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.587678Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T08:14:34.587727Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.587730Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.587735Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.587741Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715659:0 ProgressState, operation type: TxCreateTable, at tablet# 72057594046644480
2025-11-14T08:14:34.587800Z 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-14T08:14:34.587805Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.587845Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715658
2025-11-14T08:14:34.587847Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.588296Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.588324Z 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-14T08:14:34.588351Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715659, partId: 0, tablet: 72057594037968897
2025-11-14T08:14:34.588356Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976715659, shardIdx: 72057594046644480:3, partId: 0
2025-11-14T08:14:34.599549Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [4:546:2452], Recipient [4:543:2450]: {EvCreateTabletReply Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897}
2025-11-14T08:14:34.599572Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-11-14T08:14:34.599601Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72057594046644480 message: Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897
2025-11-14T08:14:34.599613Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976715659, shardIdx: 72057594046644480:3, partId: 0
2025-11-14T08:14:34.599633Z 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-14T08:14:34.599640Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715659:0 HandleReply TEvCreateTabletReply, at tabletId: 72057594046644480
2025-11-14T08:14:34.599644Z 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-14T08:14:34.599670Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 2 -> 3
2025-11-14T08:14:34.599695Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.599701Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:3
2025-11-14T08:14:34.600427Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.600442Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.600448Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T08:14:34.600493Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.600500Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.600509Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.600516Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TConfigureParts operationId# 281474976715659:0 ProgressState at tabletId# 72057594046644480
2025-11-14T08:14:34.600543Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable TConfigureParts operationId# 281474976715659:0 ProgressState Propose modify scheme on datashard datashardId: 72075186224037890 seqNo: 2:1
2025-11-14T08:14:34.600675Z 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: 543 RawX2: 17179871634 } 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-14T08:14:34.600694Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.601207Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.601219Z 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-14T08:14:34.601245Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715659, partId: 0, tablet: 72075186224037890
2025-11-14T08:14:34.649281Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [4:546:2452], Recipient [4:543:2450]: {EvTabletCreationResult Status: OK TabletID: 72075186224037890}
2025-11-14T08:14:34.680371Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1521:2943], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72075186224037890 Status: OK ServerId: [5:1571:2449] Leader: 1 Dead: 0 Generation: 1 VersionInfo:  }
2025-11-14T08:14:34.680393Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T08:14:34.680399Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037890, status: OK, at schemeshard: 72057594046644480
2025-11-14T08:14:34.702275Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269550080, Sender [5:1538:2430], Recipient [4:543:2450]
2025-11-14T08:14:34.702309Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvProposeTransactionResult
2025-11-14T08:14:34.702880Z 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: 87 } }
2025-11-14T08:14:34.702900Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715659, tablet: 72075186224037890, partId: 0
2025-11-14T08:14:34.702934Z 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: 87 } }
2025-11-14T08:14:34.702943Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TConfigureParts operationId# 281474976715659:0 HandleReply TEvProposeTransactionResult at tabletId# 72057594046644480
2025-11-14T08:14:34.702952Z 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: 87 } }
2025-11-14T08:14:34.702956Z node 4 :FLAT_TX_SCHEMESHARD INFO: TEvProposeTransactionResult at tablet: 72057594046644480
2025-11-14T08:14:34.702977Z 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-14T08:14:34.702981Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 3 -> 128
2025-11-14T08:14:34.702989Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.702995Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72075186224037890 cookie: 72057594046644480:3
2025-11-14T08:14:34.703729Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.703747Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.703753Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T08:14:34.703797Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.703806Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.703817Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.703824Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TPropose operationId# 281474976715659:0 HandleReply ProgressState at tablet: 72057594046644480
2025-11-14T08:14:34.703832Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.703840Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976715659 ready parts: 1/1
2025-11-14T08:14:34.703877Z 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-14T08:14:34.704420Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.704438Z 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-14T08:14:34.704464Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715659, partId: 4294967295, tablet: 72075186224037888
2025-11-14T08:14:34.704723Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [5:1387:2370], Recipient [4:543:2450]
2025-11-14T08:14:34.705285Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [5:1387:2370], Recipient [4:543:2450]
2025-11-14T08:14:34.705407Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1594:2957], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:34.705412Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:34.705416Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:14:34.705645Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [5:1464:2410], Recipient [4:1594:2957]
2025-11-14T08:14:34.705649Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-11-14T08:14:34.705658Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1560, transactions count in step: 1, at schemeshard: 72057594046644480
2025-11-14T08:14:34.705674Z 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-14T08:14:34.705679Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TPropose operationId# 281474976715659:0 HandleReply TEvOperationPlan at tablet: 72057594046644480, stepId: 1560
2025-11-14T08:14:34.705703Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 128 -> 129
2025-11-14T08:14:34.705713Z node 4 :FLAT_TX_SCHEMESHARD TRACE: NTableState::TProposedWaitParts operationId# 281474976715659:0 Constructed
2025-11-14T08:14:34.705719Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.705732Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 4
2025-11-14T08:14:34.705740Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 3
2025-11-14T08:14:34.705746Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715659:4294967295 from tablet: 72057594046644480 to tablet: 0 cookie: 0:281474976715659
2025-11-14T08:14:34.706956Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.706966Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1560
2025-11-14T08:14:34.706971Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T08:14:34.707018Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.707022Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.707034Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T08:14:34.707037Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T08:14:34.707079Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 3]
2025-11-14T08:14:34.707116Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T08:14:34.707119Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 2
2025-11-14T08:14:34.707123Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 3
2025-11-14T08:14:34.707228Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.707235Z node 4 :FLAT_TX_SCHEMESHARD INFO: NTableState::TProposedWaitParts operationId# 281474976715659:0 ProgressState at tablet: 72057594046644480
2025-11-14T08:14:34.707247Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.707458Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 6 }
2025-11-14T08:14:34.707465Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:14:34.707477Z 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-14T08:14:34.707485Z 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-14T08:14:34.707488Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T08:14:34.707491Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 6
2025-11-14T08:14:34.707494Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T08:14:34.707505Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.707655Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 3] Version: 3 }
2025-11-14T08:14:34.707663Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:14:34.707669Z 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-14T08:14:34.707675Z 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-14T08:14:34.707677Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T08:14:34.707679Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], version: 3
2025-11-14T08:14:34.707697Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 4
2025-11-14T08:14:34.707705Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 0/1, is published: true
2025-11-14T08:14:34.707708Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.708346Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.709469Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T08:14:34.709480Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.709514Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T08:14:34.709516Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.709934Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269550080, Sender [5:1538:2430], Recipient [4:543:2450]
2025-11-14T08:14:34.709942Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvProposeTransactionResult
2025-11-14T08:14:34.709985Z 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: 6 DomainCoordinators: 72075186224037888 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 312 } }
2025-11-14T08:14:34.709991Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715659, tablet: 72075186224037890, partId: 0
2025-11-14T08:14:34.710010Z 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: 6 DomainCoordinators: 72075186224037888 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 312 } }
2025-11-14T08:14:34.710021Z 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: 6 DomainCoordinators: 72075186224037888 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 312 } }
2025-11-14T08:14:34.710030Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.710176Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1624:2972], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:34.710182Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:34.710185Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:14:34.710571Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269551620, Sender [5:1538:2430], Recipient [4:1624:2972]
2025-11-14T08:14:34.710581Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvSchemaChanged
2025-11-14T08:14:34.710608Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvSchemaChanged, tabletId: 72057594046644480, at schemeshard: 72057594046644480, message: Source { RawX1: 1538 RawX2: 21474838910 } Origin: 72075186224037890 State: 2 TxId: 281474976715659 Step: 0 Generation: 1
2025-11-14T08:14:34.710612Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715659, tablet: 72075186224037890, partId: 0
2025-11-14T08:14:34.710624Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvSchemaChanged> execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480, message: Source { RawX1: 1538 RawX2: 21474838910 } Origin: 72075186224037890 State: 2 TxId: 281474976715659 Step: 0 Generation: 1
2025-11-14T08:14:34.710629Z node 4 :FLAT_TX_SCHEMESHARD INFO: NTableState::TProposedWaitParts operationId# 281474976715659:0 HandleReply TEvDataShard::TEvSchemaChanged at tablet: 72057594046644480
2025-11-14T08:14:34.710634Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NTableState::TProposedWaitParts operationId# 281474976715659:0 HandleReply TEvDataShard::TEvSchemaChanged at tablet: 72057594046644480 message: Source { RawX1: 1538 RawX2: 21474838910 } Origin: 72075186224037890 State: 2 TxId: 281474976715659 Step: 0 Generation: 1
2025-11-14T08:14:34.710643Z 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-14T08:14:34.710647Z node 4 :FLAT_TX_SCHEMESHARD INFO: all shard schema changes has been received, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.710652Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: send schema changes ack message, operation: 281474976715659:0, datashard: 72075186224037890, at schemeshard: 72057594046644480
2025-11-14T08:14:34.710659Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 129 -> 240
2025-11-14T08:14:34.710680Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.710777Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.710781Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.711197Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvSchemaChanged> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.711208Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.711215Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T08:14:34.711229Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [5:1538:2430] msg type: 269552132 msg: NKikimrTxDataShard.TEvSchemaChangedResult TxId: 281474976715659 at schemeshard: 72057594046644480
2025-11-14T08:14:34.711261Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.711286Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:14:34.711292Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:14:34.711297Z node 4 :FLAT_TX_SCHEMESHARD INFO: [72057594046644480] TDone opId# 281474976715659:0 ProgressState
2025-11-14T08:14:34.711306Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:14:34.711309Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715659:0 progress is 1/1
2025-11-14T08:14:34.711312Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715659 ready parts: 1/1
2025-11-14T08:14:34.711316Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715659:0 progress is 1/1
2025-11-14T08:14:34.711318Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715659 ready parts: 1/1
2025-11-14T08:14:34.711321Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 1/1, is published: true
2025-11-14T08:14:34.711329Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoNotify send TEvNotifyTxCompletionResult to actorId: [4:1297:2843] message: TxId: 281474976715659
2025-11-14T08:14:34.711333Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715659 ready parts: 1/1
2025-11-14T08:14:34.711337Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976715659:0
2025-11-14T08:14:34.711340Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976715659:0
2025-11-14T08:14:34.711363Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 3
2025-11-14T08:14:34.711917Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.711941Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [4:1297:2843] msg type: 271124998 msg: NKikimrScheme.TEvNotifyTxCompletionResult TxId: 281474976715659 at schemeshard: 72057594046644480
2025-11-14T08:14:34.712038Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1337:2858], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:14:34.712045Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:14:34.712049Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T08:14:34.722725Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715660. Ctx: { TraceId: 01ka0pwd6s8hsyaet4t6bmwx0f, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=OTk4M2YwNTEtNDk0MjA2NjMtYTk3NjIyNzMtMWEzZGE1N2U=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-11-14T08:14:34.735473Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1624:2972], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:14:34.735492Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:14:34.735496Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T08:14:34.736234Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1656:2996], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:34.736248Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:34.736253Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:14:34.736299Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122945, Sender [4:1653:2993], Recipient [4:543:2450]: NKikimrSchemeOp.TDescribePath Path: "/Root/tenant/table" Options { ShowPrivateTable: true }
2025-11-14T08:14:34.736305Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvDescribeScheme
2025-11-14T08:14:34.738910Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1674:3003], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:34.738925Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:14:34.738928Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:14:34.739067Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [5:1538:2430], Recipient [4:1674:3003]
2025-11-14T08:14:34.739072Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-11-14T08:14:34.739092Z 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-14T08:14:34.739141Z 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: 1523 LastUpdateTime: 1523 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-14T08:14:34.739150Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.100000s, queue# 1
2025-11-14T08:14:34.832169Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T08:14:34.832196Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T08:14:34.832201Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 1
2025-11-14T08:14:34.832219Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 1
2025-11-14T08:14:34.832225Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.000000s, queue# 1
2025-11-14T08:14:34.832266Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: PersistSingleStats for pathId 3 shard idx 72057594046644480:3 data size 75 row count 1
2025-11-14T08:14:34.832286Z 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-14T08:14:34.832299Z node 4 :FLAT_TX_SCHEMESHARD INFO: Add stats from shard with datashardId(TabletID)=72075186224037890 followerId=0, pathId 3: RowCount 1, DataSize 75
2025-11-14T08:14:34.832304Z node 4 :FLAT_TX_SCHEMESHARD TRACE: BuildStatsForCollector: datashardId 72075186224037890, followerId 0
2025-11-14T08:14:34.832326Z 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-14T08:14:34.832473Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T08:14:34.832480Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 0, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T08:14:34.833250Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:34.833272Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T08:14:34.833277Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 0, path id: 2
2025-11-14T08:14:34.833607Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 7 }
2025-11-14T08:14:34.833615Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:14:34.833634Z 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-14T08:14:34.844258Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T08:14:34.844290Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T08:14:34.844297Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-11-14T08:14:35.043446Z node 5 :TX_CONVEYOR ERROR: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-11-14T08:14:35.136726Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:35.136755Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:35.136781Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:35.136786Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:35.715395Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:35.715418Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:35.715438Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:35.715442Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:36.201140Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:36.201163Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:36.201195Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:36.201200Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:36.707104Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:36.707134Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:36.707158Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:36.707164Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:37.255628Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:37.255649Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:37.255680Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:37.255684Z 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: 1523 LastUpdateTime: 1523 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: 82328 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1458 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T08:14:37.461390Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [5:1538:2430], Recipient [4:543:2450]: NKikimrTxDataShard.TEvPeriodicTableStats DatashardId: 72075186224037890 TableLocalId: 3 Generation: 1 Round: 1 TableStats { DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1523 LastUpdateTime: 1523 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: 82328 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1458 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T08:14:37.461405Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-11-14T08:14:37.461417Z 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-14T08:14:37.461435Z 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: 1523 LastUpdateTime: 1523 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-14T08:14:37.461443Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.100000s, queue# 1
2025-11-14T08:14:37.471695Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715661. Ctx: { TraceId: 01ka0pwfwn9smzwp3eytc8d8tt, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=MjQ1MzBhNzEtMjFmMWMxZjUtODczNjJlNWQtNWRlNDdjYzc=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-11-14T08:14:37.472091Z node 5 :TX_DATASHARD ERROR: Cannot perform writes: database is out of disk space
2025-11-14T08:14:37.472119Z 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-14T08:14:37.472141Z 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-14T08:14:37.472270Z node 4 :KQP_EXECUTER ERROR: ActorId: [4:1828:3105] TxId: 281474976715661. Ctx: { TraceId: 01ka0pwfwn9smzwp3eytc8d8tt, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=MjQ1MzBhNzEtMjFmMWMxZjUtODczNjJlNWQtNWRlNDdjYzc=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. ERROR: [DISK_SPACE_EXHAUSTED] Cannot perform writes: database is out of disk space; 
2025-11-14T08:14:37.473441Z node 4 :KQP_SESSION WARN: SessionId: ydb://session/3?node_id=4&id=MjQ1MzBhNzEtMjFmMWMxZjUtODczNjJlNWQtNWRlNDdjYzc=, ActorId: [4:1818:3105], ActorState: ExecuteState, TraceId: 01ka0pwfwn9smzwp3eytc8d8tt, Create QueryResponse for error on request, msg: 
2025-11-14T08:14:37.473659Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715662. Ctx: { TraceId: 01ka0pwfwn9smzwp3eytc8d8tt, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=MjQ1MzBhNzEtMjFmMWMxZjUtODczNjJlNWQtNWRlNDdjYzc=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-11-14T08:14:37.535345Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T08:14:37.535371Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T08:14:37.535377Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 1
2025-11-14T08:14:37.535398Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 1
2025-11-14T08:14:37.535404Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.000000s, queue# 1
2025-11-14T08:14:37.535445Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: PersistSingleStats for pathId 3 shard idx 72057594046644480:3 data size 75 row count 1
2025-11-14T08:14:37.535464Z 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-14T08:14:37.535475Z node 4 :FLAT_TX_SCHEMESHARD INFO: Add stats from shard with datashardId(TabletID)=72075186224037890 followerId=0, pathId 3: RowCount 1, DataSize 75
2025-11-14T08:14:37.535480Z node 4 :FLAT_TX_SCHEMESHARD TRACE: BuildStatsForCollector: datashardId 72075186224037890, followerId 0
2025-11-14T08:14:37.535502Z 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-14T08:14:37.535645Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T08:14:37.535652Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 0, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T08:14:37.536357Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:14:37.536380Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T08:14:37.536386Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 0, path id: 2
2025-11-14T08:14:37.536604Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 8 }
2025-11-14T08:14:37.536613Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:14:37.536636Z 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-14T08:14:37.547272Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T08:14:37.547298Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T08:14:37.547304Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-11-14T08:14:37.775973Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:37.776012Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:37.776039Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:37.776044Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:38.270741Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:38.270766Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:38.270790Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:38.270795Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:38.755829Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:38.755856Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:38.755880Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:38.755885Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:39.483027Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:39.483055Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:39.483080Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:39.483084Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:40.266146Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:40.266177Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:14:40.266203Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:14:40.266208Z 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: 1523 LastUpdateTime: 1523 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: 82328 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1458 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T08:14:40.566524Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [5:1538:2430], Recipient [4:543:2450]: NKikimrTxDataShard.TEvPeriodicTableStats DatashardId: 72075186224037890 TableLocalId: 3 Generation: 1 Round: 2 TableStats { DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1523 LastUpdateTime: 1523 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: 82328 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1458 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T08:14:40.566541Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-11-14T08:14:40.566557Z 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-14T08:14:40.566577Z 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: 1523 LastUpdateTime: 1523 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-14T08:14:40.566585Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.100000s, queue# 1
2025-11-14T08:14:40.576527Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715663. Ctx: { TraceId: 01ka0pwjxqapypbmge986vqbss, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=MjMyYzY2MzAtMmI2NTk1NjMtZWNiYzY4MzMtNjU2MDJhNzE=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
