2025-11-26T16:24:36.851632Z 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/vw16/000ffa/r3tmp/tmp5aGiav/pdisk_1.dat
2025-11-26T16:24:37.025055Z 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-26T16:24:37.089996Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-26T16:24:37.090032Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-26T16:24:37.101508Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-11-26T16:24:37.352634Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:967:2781], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:37.352653Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:37.352658Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-26T16:24:37.352676Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [4:964:2779], Recipient [4:522:2434]: {TEvModifySchemeTransaction txid# 281474976715657 TabletId# 72057594046644480}
2025-11-26T16:24:37.352681Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-11-26T16:24:37.360734Z 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-26T16:24:37.360818Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TCreateSubDomain Propose, path: /Root/tenant, opId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-26T16:24:37.360842Z 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-26T16:24:37.360889Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 0
2025-11-26T16:24:37.360927Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason  for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 1
2025-11-26T16:24:37.360949Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976715657:1, propose status:StatusAccepted, reason: , at schemeshard: 72057594046644480
2025-11-26T16:24:37.360953Z 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-26T16:24:37.360959Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.360965Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 1
2025-11-26T16:24:37.360972Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-26T16:24:37.361651Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976715657, response: Status: StatusAccepted TxId: 281474976715657 SchemeshardId: 72057594046644480 PathId: 2, at schemeshard: 72057594046644480
2025-11-26T16:24:37.361681Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976715657, database: /Root, subject: , status: StatusAccepted, operation: CREATE DATABASE, path: /Root/tenant
2025-11-26T16:24:37.361688Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.361694Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-26T16:24:37.361751Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-26T16:24:37.361757Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-26T16:24:37.361787Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-26T16:24:37.361793Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 1]
2025-11-26T16:24:37.361823Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-26T16:24:37.361842Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-26T16:24:37.361846Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:755:2601], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 1
2025-11-26T16:24:37.361851Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:755:2601], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 2
2025-11-26T16:24:37.361865Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-26T16:24:37.361873Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715657:0 ProgressState, operation type: TxCreateSubDomain, at tablet# 72057594046644480
2025-11-26T16:24:37.361877Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715657:0 ProgressState no shards to create, do next state
2025-11-26T16:24:37.361882Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715657:0 2 -> 3
2025-11-26T16:24:37.361896Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.361986Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:967:2781], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-26T16:24:37.361991Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-26T16:24:37.361995Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-26T16:24:37.362381Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:755:2601], Recipient [4:522:2434]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 1] Version: 4 }
2025-11-26T16:24:37.362390Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-26T16:24:37.362402Z 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-26T16:24:37.362414Z 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-26T16:24:37.362417Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-26T16:24:37.362422Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 1], version: 4
2025-11-26T16:24:37.362428Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 2
2025-11-26T16:24:37.362445Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.362740Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:755:2601], Recipient [4:522:2434]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 2 }
2025-11-26T16:24:37.362748Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-26T16:24:37.362757Z 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-26T16:24:37.362770Z 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-26T16:24:37.362774Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-26T16:24:37.362777Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 2
2025-11-26T16:24:37.362782Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 3
2025-11-26T16:24:37.362794Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715657, ready parts: 0/1, is published: true
2025-11-26T16:24:37.362798Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.363034Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.363042Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-26T16:24:37.363202Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-26T16:24:37.363208Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-26T16:24:37.363215Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-26T16:24:37.363220Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715657:0 ProgressState, at schemeshard: 72057594046644480
2025-11-26T16:24:37.363225Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715657:0 3 -> 128
2025-11-26T16:24:37.363238Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.363375Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-26T16:24:37.363381Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.363644Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-26T16:24:37.363651Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.363883Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.363891Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-26T16:24:37.363912Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-26T16:24:37.363916Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-26T16:24:37.363922Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-26T16:24:37.363927Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose ProgressState, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-26T16:24:37.363933Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose ProgressState leave, operationId 281474976715657:0, at tablet# 72057594046644480
2025-11-26T16:24:37.363936Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.363945Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976715657 ready parts: 1/1
2025-11-26T16:24:37.364534Z 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-26T16:24:37.364978Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.364991Z 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-26T16:24:37.365013Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715657, partId: 4294967295, tablet: 72057594046316545
2025-11-26T16:24:37.365068Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:512:2424], Recipient [4:522:2434]: NKikimrTx.TEvProposeTransactionStatus Status: 16 StepId: 1000 TxId: 281474976715657
2025-11-26T16:24:37.365136Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:987:2801], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:37.365140Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:37.365142Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-26T16:24:37.365158Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124996, Sender [4:905:2726], Recipient [4:522:2434]: NKikimrScheme.TEvNotifyTxCompletion TxId: 281474976715657
2025-11-26T16:24:37.365162Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvNotifyTxCompletion
2025-11-26T16:24:37.365171Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NotifyTxCompletion operation in-flight, txId: 281474976715657, at schemeshard: 72057594046644480
2025-11-26T16:24:37.365175Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715657, ready parts: 0/1, is published: true
2025-11-26T16:24:37.365181Z node 4 :FLAT_TX_SCHEMESHARD INFO: NotifyTxCompletion transaction is registered, txId: 281474976715657, at schemeshard: 72057594046644480
2025-11-26T16:24:37.684222Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:512:2424], Recipient [4:522:2434]: NKikimrTx.TEvProposeTransactionStatus Status: 17 StepId: 1000 TxId: 281474976715657
2025-11-26T16:24:37.684328Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [4:737:2585], Recipient [4:522:2434]: {TEvPlanStep step# 1000 MediatorId# 72057594046382081 TabletID 72057594046644480}
2025-11-26T16:24:37.684336Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-11-26T16:24:37.684350Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1000, transactions count in step: 1, at schemeshard: 72057594046644480
2025-11-26T16:24:37.684410Z 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-26T16:24:37.684423Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715657:0, at tablet# 72057594046644480
2025-11-26T16:24:37.684489Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715657:0 128 -> 240
2025-11-26T16:24:37.684503Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715657:0, at tablet# 72057594046644480
2025-11-26T16:24:37.684530Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.684545Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 1
2025-11-26T16:24:37.684557Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-26T16:24:37.684566Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715657:4294967295 from tablet: 72057594046644480 to tablet: 0 cookie: 0:281474976715657
2025-11-26T16:24:37.684572Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DoUpdateTenant no IsExternalSubDomainRoot, pathId: : [OwnerId: 72057594046644480, LocalPathId: 2], at schemeshard: 72057594046644480
2025-11-26T16:24:37.685166Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.685181Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1000
2025-11-26T16:24:37.685189Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-26T16:24:37.685289Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-26T16:24:37.685295Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-26T16:24:37.685322Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-26T16:24:37.685329Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 1]
2025-11-26T16:24:37.685361Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-26T16:24:37.685377Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-26T16:24:37.685382Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:755:2601], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 1
2025-11-26T16:24:37.685387Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:755:2601], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 2
2025-11-26T16:24:37.685401Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-26T16:24:37.685412Z node 4 :FLAT_TX_SCHEMESHARD INFO: [72057594046644480] TDone opId# 281474976715657:0 ProgressState
2025-11-26T16:24:37.685424Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.685429Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715657:0 progress is 1/1
2025-11-26T16:24:37.685433Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715657 ready parts: 1/1
2025-11-26T16:24:37.685438Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715657:0 progress is 1/1
2025-11-26T16:24:37.685441Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715657 ready parts: 1/1
2025-11-26T16:24:37.685446Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715657, ready parts: 1/1, is published: false
2025-11-26T16:24:37.685453Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715657 ready parts: 1/1
2025-11-26T16:24:37.685458Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976715657:0
2025-11-26T16:24:37.685461Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976715657:0
2025-11-26T16:24:37.685471Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 3
2025-11-26T16:24:37.685477Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication still in progress, tx: 281474976715657, publications: 2, subscribers: 1
2025-11-26T16:24:37.685481Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Publication details:  tx: 281474976715657, [OwnerId: 72057594046644480, LocalPathId: 1], 5
2025-11-26T16:24:37.685485Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Publication details:  tx: 281474976715657, [OwnerId: 72057594046644480, LocalPathId: 2], 3
2025-11-26T16:24:37.685773Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:755:2601], Recipient [4:522:2434]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 1] Version: 5 }
2025-11-26T16:24:37.685783Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-26T16:24:37.685801Z 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-26T16:24:37.685813Z 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-26T16:24:37.685818Z node 4 :FLAT_TX_SCHEMESHARD INFO: Publication in-flight, count: 2, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-26T16:24:37.685822Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 1], version: 5
2025-11-26T16:24:37.685827Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 2
2025-11-26T16:24:37.685841Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.686132Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:755:2601], Recipient [4:522:2434]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 3 }
2025-11-26T16:24:37.686140Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-26T16:24:37.686149Z 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-26T16:24:37.686163Z 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-26T16:24:37.686167Z node 4 :FLAT_TX_SCHEMESHARD INFO: Publication in-flight, count: 1, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-26T16:24:37.686171Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 3
2025-11-26T16:24:37.686175Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-26T16:24:37.686186Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication complete, notify & remove, at schemeshard: 72057594046644480, txId: 281474976715657, subscribers: 1
2025-11-26T16:24:37.686191Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Notify send TEvNotifyTxCompletionResult, at schemeshard: 72057594046644480, to actorId: [4:905:2726]
2025-11-26T16:24:37.686196Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.686699Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.687094Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-26T16:24:37.687102Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.687121Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-26T16:24:37.687125Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.687140Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [4:905:2726] msg type: 271124998 msg: NKikimrScheme.TEvNotifyTxCompletionResult TxId: 281474976715657 at schemeshard: 72057594046644480
2025-11-26T16:24:37.687708Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1019:2826], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:37.687717Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:37.687725Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-26T16:24:37.687742Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [4:1009:2823], Recipient [4:522:2434]: {TEvModifySchemeTransaction txid# 281474976715658 TabletId# 72057594046644480}
2025-11-26T16:24:37.687747Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-11-26T16:24:37.688544Z 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-26T16:24:37.688604Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TAlterSubDomain Propose, path: /Root/tenant, opId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-26T16:24:37.688654Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 1
2025-11-26T16:24:37.688663Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-26T16:24:37.688669Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 3
2025-11-26T16:24:37.688746Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976715658:1, propose status:StatusAccepted, reason: , at schemeshard: 72057594046644480
2025-11-26T16:24:37.688767Z 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-26T16:24:37.688779Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.689259Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976715658, response: Status: StatusAccepted TxId: 281474976715658 SchemeshardId: 72057594046644480 PathId: 2, at schemeshard: 72057594046644480
2025-11-26T16:24:37.689289Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976715658, database: /Root, subject: , status: StatusAccepted, operation: ALTER DATABASE, path: /Root/tenant
2025-11-26T16:24:37.689294Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.689300Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-26T16:24:37.689330Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-26T16:24:37.689335Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-26T16:24:37.689343Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-26T16:24:37.689351Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715658:0 ProgressState, operation type: TxAlterSubDomain, at tablet# 72057594046644480
2025-11-26T16:24:37.689409Z 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-26T16:24:37.689427Z 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-26T16:24:37.689432Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.689542Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1019:2826], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-26T16:24:37.689548Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-26T16:24:37.689552Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-26T16:24:37.689910Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.689921Z 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-26T16:24:37.689961Z 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-26T16:24:37.689974Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 0, tablet: 72057594037968897
2025-11-26T16:24:37.689980Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:1, partId: 0
2025-11-26T16:24:37.689985Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:2, partId: 0
2025-11-26T16:24:37.690063Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1026:2833], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72057594037968897 Status: OK ServerId: [4:1027:2834] Leader: 1 Dead: 0 Generation: 2 VersionInfo:  }
2025-11-26T16:24:37.690068Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-26T16:24:37.690073Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72057594037968897, status: OK, at schemeshard: 72057594046644480
2025-11-26T16:24:37.955685Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1300:2846], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:37.955703Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:37.955707Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-26T16:24:37.956346Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122945, Sender [5:1267:2343], Recipient [4:1300:2846]
2025-11-26T16:24:37.956362Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvDescribeScheme
2025-11-26T16:24:37.958712Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1332:2854], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:37.958724Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:37.958727Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-26T16:24:37.958754Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [4:1299:2845], Recipient [4:522:2434]: {TEvModifySchemeTransaction txid# 281474976715659 TabletId# 72057594046644480}
2025-11-26T16:24:37.958757Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-11-26T16:24:37.959436Z 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-26T16:24:37.959494Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TCreateTable Propose, path: /Root/tenant/table, opId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-26T16:24:37.959511Z 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-26T16:24:37.959603Z 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-26T16:24:37.959613Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 0
2025-11-26T16:24:37.959619Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 1
2025-11-26T16:24:37.959635Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new path created for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 2
2025-11-26T16:24:37.959646Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 1 -> 2
2025-11-26T16:24:37.959791Z 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-26T16:24:37.959805Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976715659:1, propose status:StatusAccepted, reason: , at schemeshard: 72057594046644480
2025-11-26T16:24:37.959811Z 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-26T16:24:37.959819Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.959826Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-26T16:24:37.959832Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 3
2025-11-26T16:24:37.960782Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976715659, response: Status: StatusAccepted TxId: 281474976715659 SchemeshardId: 72057594046644480 PathId: 3, at schemeshard: 72057594046644480
2025-11-26T16:24:37.960820Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976715659, database: /Root/tenant, subject: , status: StatusAccepted, operation: CREATE TABLE, path: /Root/tenant/table
2025-11-26T16:24:37.960828Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.960835Z node 4 :FLAT_TX_SCHEMESHARD INFO: Delay activating, operation part: 281474976715659:0, there is await operations num 1
2025-11-26T16:24:37.960874Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-26T16:24:37.960880Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-26T16:24:37.960907Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 3]
2025-11-26T16:24:37.960922Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-26T16:24:37.960927Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:755:2601], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 2
2025-11-26T16:24:37.960932Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:755:2601], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 3
2025-11-26T16:24:37.961124Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1332:2854], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-26T16:24:37.961131Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-26T16:24:37.961139Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-26T16:24:37.961230Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:755:2601], Recipient [4:522:2434]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 4 }
2025-11-26T16:24:37.961237Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-26T16:24:37.961250Z 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-26T16:24:37.961260Z 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-26T16:24:37.961265Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-26T16:24:37.961270Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 4
2025-11-26T16:24:37.961275Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 6
2025-11-26T16:24:37.961296Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.961391Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1338:2859], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:37.961396Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:37.961400Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-26T16:24:37.961567Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124996, Sender [4:1298:2844], Recipient [4:522:2434]: NKikimrScheme.TEvNotifyTxCompletion TxId: 281474976715659
2025-11-26T16:24:37.961575Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvNotifyTxCompletion
2025-11-26T16:24:37.961583Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NotifyTxCompletion operation in-flight, txId: 281474976715659, at schemeshard: 72057594046644480
2025-11-26T16:24:37.961588Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 0/1, is published: false
2025-11-26T16:24:37.961593Z node 4 :FLAT_TX_SCHEMESHARD INFO: NotifyTxCompletion transaction is registered, txId: 281474976715659, at schemeshard: 72057594046644480
2025-11-26T16:24:37.961633Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:755:2601], Recipient [4:522:2434]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 3] Version: 1 }
2025-11-26T16:24:37.961639Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-26T16:24:37.961647Z 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-26T16:24:37.961654Z 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-26T16:24:37.961658Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-26T16:24:37.961665Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], version: 1
2025-11-26T16:24:37.961669Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 4
2025-11-26T16:24:37.961681Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 0/1, is published: true
2025-11-26T16:24:37.961685Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.962467Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-26T16:24:37.962479Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.962762Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-26T16:24:37.962774Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.963068Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(5, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-26T16:24:37.963087Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(5, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-26T16:24:37.994510Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [4:529:2441], Recipient [4:522:2434]: {EvCreateTabletReply Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897}
2025-11-26T16:24:37.994528Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-11-26T16:24:37.994565Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72057594046644480 message: Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897
2025-11-26T16:24:37.994576Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:1, partId: 0
2025-11-26T16:24:37.994608Z 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-26T16:24:37.994617Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, at tabletId: 72057594046644480
2025-11-26T16:24:37.994632Z 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-26T16:24:37.994655Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.994662Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:1
2025-11-26T16:24:37.994894Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [4:529:2441], Recipient [4:522:2434]: {EvCreateTabletReply Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897}
2025-11-26T16:24:37.994901Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-11-26T16:24:37.994910Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72057594046644480 message: Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897
2025-11-26T16:24:37.994915Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:2, partId: 0
2025-11-26T16:24:37.994927Z 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-26T16:24:37.994932Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, at tabletId: 72057594046644480
2025-11-26T16:24:37.994937Z 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-26T16:24:37.994950Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715658:0 2 -> 3
2025-11-26T16:24:37.994965Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.994970Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:2
2025-11-26T16:24:37.995008Z node 4 :HIVE WARN: HIVE#72057594037968897 Handle TEvInterconnect::TEvNodeConnected, NodeId 5 Cookie 5
2025-11-26T16:24:37.995608Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(5, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-11-26T16:24:37.996094Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-26T16:24:37.996106Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.996238Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-26T16:24:37.996242Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.996246Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-26T16:24:37.996268Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-26T16:24:37.996272Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-26T16:24:37.996276Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-26T16:24:37.996282Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715658:0 ProgressState, at schemeshard: 72057594046644480
2025-11-26T16:24:37.996294Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send configure request to coordinator/mediator: 72075186224037888 opId: 281474976715658:0 schemeshard: 72057594046644480
2025-11-26T16:24:37.996298Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send configure request to coordinator/mediator: 72075186224037889 opId: 281474976715658:0 schemeshard: 72057594046644480
2025-11-26T16:24:37.996302Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:37.996716Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:37.996727Z 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-26T16:24:37.996767Z 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-26T16:24:37.996779Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 0, tablet: 72075186224037888
2025-11-26T16:24:37.996782Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 0, tablet: 72075186224037889
2025-11-26T16:24:38.051909Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [4:529:2441], Recipient [4:522:2434]: {EvTabletCreationResult Status: OK TabletID: 72075186224037888}
2025-11-26T16:24:38.051931Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [4:529:2441], Recipient [4:522:2434]: {EvTabletCreationResult Status: OK TabletID: 72075186224037889}
2025-11-26T16:24:38.093751Z node 4 :TX_CONVEYOR ERROR: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-11-26T16:24:38.104925Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1357:2878], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72075186224037888 Status: OK ServerId: [5:1452:2401] Leader: 1 Dead: 0 Generation: 1 VersionInfo:  }
2025-11-26T16:24:38.104946Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-26T16:24:38.104952Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037888, status: OK, at schemeshard: 72057594046644480
2025-11-26T16:24:38.104976Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:38.104981Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:38.105151Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1358:2879], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72075186224037889 Status: OK ServerId: [5:1453:2402] Leader: 1 Dead: 0 Generation: 1 VersionInfo:  }
2025-11-26T16:24:38.105156Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-26T16:24:38.105158Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037889, status: OK, at schemeshard: 72057594046644480
2025-11-26T16:24:38.107054Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 272564225, Sender [5:1388:2370], Recipient [4:522:2434]
2025-11-26T16:24:38.107067Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSubDomain::TEvConfigureStatus
2025-11-26T16:24:38.107096Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715658, tablet: 72075186224037888, partId: 0
2025-11-26T16:24:38.107167Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: SUCCESS OnTabletId: 72075186224037888
2025-11-26T16:24:38.107185Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715658:0 HandleReply TEvConfigureStatus operationId:281474976715658:0 at schemeshard:72057594046644480
2025-11-26T16:24:38.107196Z 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-26T16:24:38.107201Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.107207Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037888 cookie: 72057594046644480:1
2025-11-26T16:24:38.107375Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 272564225, Sender [5:1390:2371], Recipient [4:522:2434]
2025-11-26T16:24:38.107381Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSubDomain::TEvConfigureStatus
2025-11-26T16:24:38.107387Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715658, tablet: 72075186224037889, partId: 0
2025-11-26T16:24:38.107399Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: SUCCESS OnTabletId: 72075186224037889
2025-11-26T16:24:38.107403Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715658:0 HandleReply TEvConfigureStatus operationId:281474976715658:0 at schemeshard:72057594046644480
2025-11-26T16:24:38.107406Z 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-26T16:24:38.107413Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715658:0 3 -> 128
2025-11-26T16:24:38.107428Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.107431Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037889 cookie: 72057594046644480:2
2025-11-26T16:24:38.108393Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-26T16:24:38.108404Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.108541Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-26T16:24:38.108546Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.108551Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-26T16:24:38.108602Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-26T16:24:38.108606Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-26T16:24:38.108614Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-26T16:24:38.108619Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose ProgressState, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-26T16:24:38.108623Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose ProgressState leave, operationId 281474976715658:0, at tablet# 72057594046644480
2025-11-26T16:24:38.108625Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.108630Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976715658 ready parts: 1/1
2025-11-26T16:24:38.108658Z 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-26T16:24:38.109192Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.109204Z 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-26T16:24:38.109227Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 4294967295, tablet: 72057594046316545
2025-11-26T16:24:38.109284Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:512:2424], Recipient [4:522:2434]: NKikimrTx.TEvProposeTransactionStatus Status: 16 StepId: 1500 TxId: 281474976715658
2025-11-26T16:24:38.400713Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:512:2424], Recipient [4:522:2434]: NKikimrTx.TEvProposeTransactionStatus Status: 17 StepId: 1500 TxId: 281474976715658
2025-11-26T16:24:38.400837Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [4:737:2585], Recipient [4:522:2434]: {TEvPlanStep step# 1500 MediatorId# 72057594046382081 TabletID 72057594046644480}
2025-11-26T16:24:38.400842Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-11-26T16:24:38.400853Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1500, transactions count in step: 1, at schemeshard: 72057594046644480
2025-11-26T16:24:38.400870Z 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-26T16:24:38.400878Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715658:0, at tablet# 72057594046644480
2025-11-26T16:24:38.400968Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715658:0 128 -> 240
2025-11-26T16:24:38.400980Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715658:0, at tablet# 72057594046644480
2025-11-26T16:24:38.400998Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.401013Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-26T16:24:38.401022Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:4294967295 from tablet: 72057594046644480 to tablet: 0 cookie: 0:281474976715658
2025-11-26T16:24:38.401026Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DoUpdateTenant no IsExternalSubDomainRoot, pathId: : [OwnerId: 72057594046644480, LocalPathId: 2], at schemeshard: 72057594046644480
2025-11-26T16:24:38.401567Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.401578Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1500
2025-11-26T16:24:38.401585Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-26T16:24:38.401675Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-26T16:24:38.401681Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-26T16:24:38.401703Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-26T16:24:38.401708Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715658, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-26T16:24:38.401754Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-26T16:24:38.401759Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:755:2601], at schemeshard: 72057594046644480, txId: 281474976715658, path id: 2
2025-11-26T16:24:38.401895Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-26T16:24:38.401906Z node 4 :FLAT_TX_SCHEMESHARD INFO: [72057594046644480] TDone opId# 281474976715658:0 ProgressState
2025-11-26T16:24:38.401915Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.401920Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715658:0 progress is 1/1
2025-11-26T16:24:38.401924Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715658 ready parts: 1/1
2025-11-26T16:24:38.401932Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715658:0 progress is 1/1
2025-11-26T16:24:38.401935Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715658 ready parts: 1/1
2025-11-26T16:24:38.401940Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715658, ready parts: 1/1, is published: false
2025-11-26T16:24:38.401945Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715658 ready parts: 1/1
2025-11-26T16:24:38.401950Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Remove dependency, parent tx: 281474976715658, dependent tx: 281474976715659
2025-11-26T16:24:38.401963Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976715658:0
2025-11-26T16:24:38.401967Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976715658:0
2025-11-26T16:24:38.401994Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 6
2025-11-26T16:24:38.402000Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication still in progress, tx: 281474976715658, publications: 1, subscribers: 0
2025-11-26T16:24:38.402004Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Publication details:  tx: 281474976715658, [OwnerId: 72057594046644480, LocalPathId: 2], 5
2025-11-26T16:24:38.402210Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:755:2601], Recipient [4:522:2434]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 5 }
2025-11-26T16:24:38.402219Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-26T16:24:38.402233Z 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-26T16:24:38.402244Z 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-26T16:24:38.402248Z node 4 :FLAT_TX_SCHEMESHARD INFO: Publication in-flight, count: 1, at schemeshard: 72057594046644480, txId: 281474976715658
2025-11-26T16:24:38.402253Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715658, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 5
2025-11-26T16:24:38.402258Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-26T16:24:38.402272Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication complete, notify & remove, at schemeshard: 72057594046644480, txId: 281474976715658, subscribers: 0
2025-11-26T16:24:38.402276Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.403349Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.403362Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-26T16:24:38.403441Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-26T16:24:38.403447Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-26T16:24:38.403454Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-26T16:24:38.403463Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715659:0 ProgressState, operation type: TxCreateTable, at tablet# 72057594046644480
2025-11-26T16:24:38.403531Z 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-26T16:24:38.403539Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.403909Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715658
2025-11-26T16:24:38.403918Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.404293Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.404302Z 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-26T16:24:38.404325Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715659, partId: 0, tablet: 72057594037968897
2025-11-26T16:24:38.404331Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976715659, shardIdx: 72057594046644480:3, partId: 0
2025-11-26T16:24:38.415637Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [4:529:2441], Recipient [4:522:2434]: {EvCreateTabletReply Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897}
2025-11-26T16:24:38.415658Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-11-26T16:24:38.415685Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72057594046644480 message: Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897
2025-11-26T16:24:38.415694Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976715659, shardIdx: 72057594046644480:3, partId: 0
2025-11-26T16:24:38.415717Z 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-26T16:24:38.415727Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715659:0 HandleReply TEvCreateTabletReply, at tabletId: 72057594046644480
2025-11-26T16:24:38.415733Z 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-26T16:24:38.415760Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 2 -> 3
2025-11-26T16:24:38.415778Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.415786Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:3
2025-11-26T16:24:38.416545Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-26T16:24:38.416558Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.416564Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-26T16:24:38.416613Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-26T16:24:38.416619Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-26T16:24:38.416629Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-26T16:24:38.416636Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TConfigureParts operationId# 281474976715659:0 ProgressState at tabletId# 72057594046644480
2025-11-26T16:24:38.416665Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable TConfigureParts operationId# 281474976715659:0 ProgressState Propose modify scheme on datashard datashardId: 72075186224037890 seqNo: 2:1
2025-11-26T16:24:38.416817Z 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: 522 RawX2: 17179871618 } 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-26T16:24:38.416839Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.417542Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.417558Z 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-26T16:24:38.417607Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715659, partId: 0, tablet: 72075186224037890
2025-11-26T16:24:38.489158Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [4:529:2441], Recipient [4:522:2434]: {EvTabletCreationResult Status: OK TabletID: 72075186224037890}
2025-11-26T16:24:38.520280Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1524:2946], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72075186224037890 Status: OK ServerId: [5:1575:2450] Leader: 1 Dead: 0 Generation: 1 VersionInfo:  }
2025-11-26T16:24:38.520300Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-26T16:24:38.520307Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037890, status: OK, at schemeshard: 72057594046644480
2025-11-26T16:24:38.532079Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269550080, Sender [5:1541:2430], Recipient [4:522:2434]
2025-11-26T16:24:38.532095Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvProposeTransactionResult
2025-11-26T16:24:38.532627Z 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: 1509512 ExecLatency: 0 ProposeLatency: 1 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 101 } }
2025-11-26T16:24:38.532641Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715659, tablet: 72075186224037890, partId: 0
2025-11-26T16:24:38.532664Z 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: 1509512 ExecLatency: 0 ProposeLatency: 1 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 101 } }
2025-11-26T16:24:38.532672Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TConfigureParts operationId# 281474976715659:0 HandleReply TEvProposeTransactionResult at tabletId# 72057594046644480
2025-11-26T16:24:38.532679Z 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: 1509512 ExecLatency: 0 ProposeLatency: 1 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 101 } }
2025-11-26T16:24:38.532682Z node 4 :FLAT_TX_SCHEMESHARD INFO: TEvProposeTransactionResult at tablet: 72057594046644480
2025-11-26T16:24:38.532705Z 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-26T16:24:38.532710Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 3 -> 128
2025-11-26T16:24:38.532719Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.532725Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72075186224037890 cookie: 72057594046644480:3
2025-11-26T16:24:38.533246Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-26T16:24:38.533253Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.533258Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-26T16:24:38.533295Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-26T16:24:38.533302Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-26T16:24:38.533309Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-26T16:24:38.533321Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TPropose operationId# 281474976715659:0 HandleReply ProgressState at tablet: 72057594046644480
2025-11-26T16:24:38.533326Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.533332Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976715659 ready parts: 1/1
2025-11-26T16:24:38.533361Z 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-26T16:24:38.533693Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.533701Z 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-26T16:24:38.533733Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715659, partId: 4294967295, tablet: 72075186224037888
2025-11-26T16:24:38.533912Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [5:1388:2370], Recipient [4:522:2434]
2025-11-26T16:24:38.534597Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [5:1388:2370], Recipient [4:522:2434]
2025-11-26T16:24:38.534703Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1598:2960], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:38.534709Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:38.534713Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-26T16:24:38.534852Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [5:1466:2410], Recipient [4:1598:2960]
2025-11-26T16:24:38.534858Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-11-26T16:24:38.534873Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1560, transactions count in step: 1, at schemeshard: 72057594046644480
2025-11-26T16:24:38.534896Z 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-26T16:24:38.534904Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TPropose operationId# 281474976715659:0 HandleReply TEvOperationPlan at tablet: 72057594046644480, stepId: 1560
2025-11-26T16:24:38.534939Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 128 -> 129
2025-11-26T16:24:38.534951Z node 4 :FLAT_TX_SCHEMESHARD TRACE: NTableState::TProposedWaitParts operationId# 281474976715659:0 Constructed
2025-11-26T16:24:38.534960Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.534973Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 4
2025-11-26T16:24:38.534985Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 3
2025-11-26T16:24:38.534995Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715659:4294967295 from tablet: 72057594046644480 to tablet: 0 cookie: 0:281474976715659
2025-11-26T16:24:38.536478Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.536489Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1560
2025-11-26T16:24:38.536496Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-26T16:24:38.536544Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-26T16:24:38.536550Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-26T16:24:38.536651Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-26T16:24:38.536658Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-26T16:24:38.536709Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 3]
2025-11-26T16:24:38.536765Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-26T16:24:38.536771Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:755:2601], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 2
2025-11-26T16:24:38.536776Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:755:2601], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 3
2025-11-26T16:24:38.536969Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-26T16:24:38.536978Z node 4 :FLAT_TX_SCHEMESHARD INFO: NTableState::TProposedWaitParts operationId# 281474976715659:0 ProgressState at tablet: 72057594046644480
2025-11-26T16:24:38.536996Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.537221Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:755:2601], Recipient [4:522:2434]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 6 }
2025-11-26T16:24:38.537228Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-26T16:24:38.537243Z 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-26T16:24:38.537254Z 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-26T16:24:38.537258Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-26T16:24:38.537263Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 6
2025-11-26T16:24:38.537268Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-26T16:24:38.537285Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.537580Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:755:2601], Recipient [4:522:2434]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 3] Version: 3 }
2025-11-26T16:24:38.537590Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-26T16:24:38.537599Z 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-26T16:24:38.537609Z 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-26T16:24:38.537613Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-26T16:24:38.537617Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], version: 3
2025-11-26T16:24:38.537622Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 4
2025-11-26T16:24:38.537634Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 0/1, is published: true
2025-11-26T16:24:38.537638Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.538669Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.539021Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-26T16:24:38.539030Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.539698Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-26T16:24:38.539709Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.540137Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269550080, Sender [5:1541:2430], Recipient [4:522:2434]
2025-11-26T16:24:38.540146Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvProposeTransactionResult
2025-11-26T16:24:38.540188Z 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: 342 } }
2025-11-26T16:24:38.540194Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715659, tablet: 72075186224037890, partId: 0
2025-11-26T16:24:38.540212Z 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: 342 } }
2025-11-26T16:24:38.540225Z 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: 342 } }
2025-11-26T16:24:38.540232Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.540561Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1629:2976], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:38.540572Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:38.540576Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-26T16:24:38.541078Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-26T16:24:38.541089Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.541169Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269551620, Sender [5:1541:2430], Recipient [4:1629:2976]
2025-11-26T16:24:38.541175Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvSchemaChanged
2025-11-26T16:24:38.541207Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvSchemaChanged, tabletId: 72057594046644480, at schemeshard: 72057594046644480, message: Source { RawX1: 1541 RawX2: 21474838910 } Origin: 72075186224037890 State: 2 TxId: 281474976715659 Step: 0 Generation: 1
2025-11-26T16:24:38.541212Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715659, tablet: 72075186224037890, partId: 0
2025-11-26T16:24:38.541240Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvSchemaChanged> execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480, message: Source { RawX1: 1541 RawX2: 21474838910 } Origin: 72075186224037890 State: 2 TxId: 281474976715659 Step: 0 Generation: 1
2025-11-26T16:24:38.541247Z node 4 :FLAT_TX_SCHEMESHARD INFO: NTableState::TProposedWaitParts operationId# 281474976715659:0 HandleReply TEvDataShard::TEvSchemaChanged at tablet: 72057594046644480
2025-11-26T16:24:38.541255Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NTableState::TProposedWaitParts operationId# 281474976715659:0 HandleReply TEvDataShard::TEvSchemaChanged at tablet: 72057594046644480 message: Source { RawX1: 1541 RawX2: 21474838910 } Origin: 72075186224037890 State: 2 TxId: 281474976715659 Step: 0 Generation: 1
2025-11-26T16:24:38.541266Z 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-26T16:24:38.541270Z node 4 :FLAT_TX_SCHEMESHARD INFO: all shard schema changes has been received, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-26T16:24:38.541275Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: send schema changes ack message, operation: 281474976715659:0, datashard: 72075186224037890, at schemeshard: 72057594046644480
2025-11-26T16:24:38.541281Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 129 -> 240
2025-11-26T16:24:38.541304Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.541756Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvSchemaChanged> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-26T16:24:38.541764Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.541771Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-26T16:24:38.541786Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [5:1541:2430] msg type: 269552132 msg: NKikimrTxDataShard.TEvSchemaChangedResult TxId: 281474976715659 at schemeshard: 72057594046644480
2025-11-26T16:24:38.541815Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-26T16:24:38.541820Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-26T16:24:38.541826Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-26T16:24:38.541833Z node 4 :FLAT_TX_SCHEMESHARD INFO: [72057594046644480] TDone opId# 281474976715659:0 ProgressState
2025-11-26T16:24:38.541842Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-26T16:24:38.541846Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715659:0 progress is 1/1
2025-11-26T16:24:38.541850Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715659 ready parts: 1/1
2025-11-26T16:24:38.541855Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715659:0 progress is 1/1
2025-11-26T16:24:38.541859Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715659 ready parts: 1/1
2025-11-26T16:24:38.541864Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 1/1, is published: true
2025-11-26T16:24:38.541873Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoNotify send TEvNotifyTxCompletionResult to actorId: [4:1298:2844] message: TxId: 281474976715659
2025-11-26T16:24:38.541880Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715659 ready parts: 1/1
2025-11-26T16:24:38.541885Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976715659:0
2025-11-26T16:24:38.541890Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976715659:0
2025-11-26T16:24:38.541916Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 3
2025-11-26T16:24:38.542353Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.542371Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [4:1298:2844] msg type: 271124998 msg: NKikimrScheme.TEvNotifyTxCompletionResult TxId: 281474976715659 at schemeshard: 72057594046644480
2025-11-26T16:24:38.542506Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1338:2859], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-26T16:24:38.542512Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-26T16:24:38.542514Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-26T16:24:38.554854Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715660. Ctx: { TraceId: 01kb0fpbwf52av8hypdfgqzdkf, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=YzlmM2JkMDItODkyYjIyMjYtYWY4MDExZDgtOGQ2YTdjYTY=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-11-26T16:24:38.567671Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1629:2976], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-26T16:24:38.567703Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-26T16:24:38.567708Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-26T16:24:38.568533Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1662:3001], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:38.568551Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:38.568556Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-26T16:24:38.568609Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122945, Sender [4:1659:2998], Recipient [4:522:2434]: NKikimrSchemeOp.TDescribePath Path: "/Root/tenant/table" Options { ShowPrivateTable: true }
2025-11-26T16:24:38.568615Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvDescribeScheme
2025-11-26T16:24:38.571538Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1680:3008], Recipient [4:522:2434]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:38.571550Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-26T16:24:38.571553Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-26T16:24:38.571775Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [5:1541:2430], Recipient [4:1680:3008]
2025-11-26T16:24:38.571783Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-11-26T16:24:38.571809Z 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-26T16:24:38.571869Z 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: 1525 LastUpdateTime: 1525 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-26T16:24:38.571879Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.100000s, queue# 1
2025-11-26T16:24:38.675598Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-26T16:24:38.675619Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-26T16:24:38.675624Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 1
2025-11-26T16:24:38.675654Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 1
2025-11-26T16:24:38.675659Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.000000s, queue# 1
2025-11-26T16:24:38.675710Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: PersistSingleStats for pathId 3 shard idx 72057594046644480:3 data size 75 row count 1
2025-11-26T16:24:38.675729Z 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-26T16:24:38.675739Z node 4 :FLAT_TX_SCHEMESHARD INFO: Add stats from shard with datashardId(TabletID)=72075186224037890 followerId=0, pathId 3: RowCount 1, DataSize 75
2025-11-26T16:24:38.675743Z node 4 :FLAT_TX_SCHEMESHARD TRACE: BuildStatsForCollector: datashardId 72075186224037890, followerId 0
2025-11-26T16:24:38.675760Z 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-26T16:24:38.675912Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-26T16:24:38.675923Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 0, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-26T16:24:38.676624Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:38.676641Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-26T16:24:38.676646Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:755:2601], at schemeshard: 72057594046644480, txId: 0, path id: 2
2025-11-26T16:24:38.676925Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:755:2601], Recipient [4:522:2434]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 7 }
2025-11-26T16:24:38.676932Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-26T16:24:38.676953Z 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-26T16:24:38.687549Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-26T16:24:38.687575Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-26T16:24:38.687581Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-11-26T16:24:38.877478Z node 5 :TX_CONVEYOR ERROR: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-11-26T16:24:38.971968Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:38.971992Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:38.972021Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:38.972026Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:39.541091Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:39.541117Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:39.541137Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:39.541146Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:40.037462Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:40.037493Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:40.037517Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:40.037520Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:40.534642Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:40.534665Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:40.534690Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:40.534693Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:41.085209Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:41.085235Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:41.085259Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:41.085264Z 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: 1525 LastUpdateTime: 1525 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: 1459 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-26T16:24:41.302143Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [5:1541:2430], Recipient [4:522:2434]: NKikimrTxDataShard.TEvPeriodicTableStats DatashardId: 72075186224037890 TableLocalId: 3 Generation: 1 Round: 1 TableStats { DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1525 LastUpdateTime: 1525 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: 1459 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-26T16:24:41.302164Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-11-26T16:24:41.302180Z 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-26T16:24:41.302200Z 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: 1525 LastUpdateTime: 1525 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-26T16:24:41.302210Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.100000s, queue# 1
2025-11-26T16:24:41.314398Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715661. Ctx: { TraceId: 01kb0fpejpfxk7khxcqq8vkezz, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=MTgwNTFiMGMtNTRiNjkxYTgtMzU2MmQyNjAtNzZmYmE3YTE=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-11-26T16:24:41.314790Z node 5 :TX_DATASHARD ERROR: Cannot perform writes: database is out of disk space
2025-11-26T16:24:41.314819Z 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-26T16:24:41.314839Z 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-26T16:24:41.314966Z node 4 :KQP_EXECUTER ERROR: ActorId: [4:1833:3110] TxId: 281474976715661. Ctx: { TraceId: 01kb0fpejpfxk7khxcqq8vkezz, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=MTgwNTFiMGMtNTRiNjkxYTgtMzU2MmQyNjAtNzZmYmE3YTE=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. ERROR: [DISK_SPACE_EXHAUSTED] Cannot perform writes: database is out of disk space; 
2025-11-26T16:24:41.316618Z node 4 :KQP_SESSION WARN: SessionId: ydb://session/3?node_id=4&id=MTgwNTFiMGMtNTRiNjkxYTgtMzU2MmQyNjAtNzZmYmE3YTE=, ActorId: [4:1823:3110], ActorState: ExecuteState, TraceId: 01kb0fpejpfxk7khxcqq8vkezz, Create QueryResponse for error on request, msg: 
2025-11-26T16:24:41.316878Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715662. Ctx: { TraceId: 01kb0fpejpfxk7khxcqq8vkezz, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=MTgwNTFiMGMtNTRiNjkxYTgtMzU2MmQyNjAtNzZmYmE3YTE=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-11-26T16:24:41.378876Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-26T16:24:41.378902Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-26T16:24:41.378909Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 1
2025-11-26T16:24:41.378929Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 1
2025-11-26T16:24:41.378935Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.000000s, queue# 1
2025-11-26T16:24:41.378981Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: PersistSingleStats for pathId 3 shard idx 72057594046644480:3 data size 75 row count 1
2025-11-26T16:24:41.379011Z 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-26T16:24:41.379026Z node 4 :FLAT_TX_SCHEMESHARD INFO: Add stats from shard with datashardId(TabletID)=72075186224037890 followerId=0, pathId 3: RowCount 1, DataSize 75
2025-11-26T16:24:41.379033Z node 4 :FLAT_TX_SCHEMESHARD TRACE: BuildStatsForCollector: datashardId 72075186224037890, followerId 0
2025-11-26T16:24:41.379058Z 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-26T16:24:41.379220Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-26T16:24:41.379227Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 0, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-26T16:24:41.379827Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-26T16:24:41.379843Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-26T16:24:41.379848Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:755:2601], at schemeshard: 72057594046644480, txId: 0, path id: 2
2025-11-26T16:24:41.380021Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:755:2601], Recipient [4:522:2434]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 8 }
2025-11-26T16:24:41.380027Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-26T16:24:41.380045Z 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-26T16:24:41.390729Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-26T16:24:41.390755Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-26T16:24:41.390761Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-11-26T16:24:41.630225Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:41.630256Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:41.630287Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:41.630293Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:42.116239Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:42.116262Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:42.116286Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:42.116290Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:42.612828Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:42.612857Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:42.612891Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:42.612897Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:43.346368Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:43.346413Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:43.346447Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:43.346452Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:44.132661Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:44.132691Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-26T16:24:44.132730Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:522:2434], Recipient [4:522:2434]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-26T16:24:44.132736Z 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: 1525 LastUpdateTime: 1525 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: 1459 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-26T16:24:44.430504Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [5:1541:2430], Recipient [4:522:2434]: NKikimrTxDataShard.TEvPeriodicTableStats DatashardId: 72075186224037890 TableLocalId: 3 Generation: 1 Round: 2 TableStats { DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1525 LastUpdateTime: 1525 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: 1459 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-26T16:24:44.430525Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-11-26T16:24:44.430539Z 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-26T16:24:44.430558Z 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: 1525 LastUpdateTime: 1525 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-26T16:24:44.430565Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.100000s, queue# 1
2025-11-26T16:24:44.439176Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715663. Ctx: { TraceId: 01kb0fphmfetfqnbm1ww5fk6kc, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=OGYyZjk2ZGQtZjlmMWZmMjAtYTk1MDM4M2EtMWE4ZTA1MTY=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
