2025-11-14T10:03:26.937034Z 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/wp2g/0015b2/r3tmp/tmps21NS6/pdisk_1.dat
2025-11-14T10:03:27.204430Z node 4 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 1:0, at schemeshard:  72057594046644480
2025-11-14T10:03:27.268962Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-14T10:03:27.268999Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-14T10:03:27.289601Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-11-14T10:03:27.616686Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:964:2778], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:27.616705Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:27.616710Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:03:27.616727Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [4:961:2776], Recipient [4:529:2441]: {TEvModifySchemeTransaction txid# 281474976715657 TabletId# 72057594046644480}
2025-11-14T10:03:27.616731Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-11-14T10:03:27.627810Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Execute, message: Transaction { WorkingDir: "/Root" OperationType: ESchemeOpCreateSubDomain SubDomain { Name: "tenant" } } TxId: 281474976715657 TabletId: 72057594046644480 PeerName: "" , at schemeshard: 72057594046644480
2025-11-14T10:03:27.627887Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TCreateSubDomain Propose, path: /Root/tenant, opId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T10:03:27.627905Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: AttachChild: child attached as only one child to the parent, parent id: [OwnerId: 72057594046644480, LocalPathId: 1], parent name: Root, child name: tenant, child id: [OwnerId: 72057594046644480, LocalPathId: 2], at schemeshard: 72057594046644480
2025-11-14T10:03:27.627955Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 0
2025-11-14T10:03:27.627991Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason  for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 1
2025-11-14T10:03:27.628018Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976715657:1, propose status:StatusAccepted, reason: , at schemeshard: 72057594046644480
2025-11-14T10:03:27.628024Z node 4 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateSubDomain, opId: 281474976715657:0, at schemeshard:  72057594046644480
2025-11-14T10:03:27.628036Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:27.628045Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 1
2025-11-14T10:03:27.628052Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T10:03:27.628963Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976715657, response: Status: StatusAccepted TxId: 281474976715657 SchemeshardId: 72057594046644480 PathId: 2, at schemeshard: 72057594046644480
2025-11-14T10:03:27.628992Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976715657, database: /Root, subject: , status: StatusAccepted, operation: CREATE DATABASE, path: /Root/tenant
2025-11-14T10:03:27.628999Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:27.629006Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T10:03:27.629075Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:03:27.629080Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:03:27.629110Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T10:03:27.629115Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 1]
2025-11-14T10:03:27.629147Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T10:03:27.629180Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T10:03:27.629185Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 1
2025-11-14T10:03:27.629189Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 2
2025-11-14T10:03:27.629203Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T10:03:27.629210Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715657:0 ProgressState, operation type: TxCreateSubDomain, at tablet# 72057594046644480
2025-11-14T10:03:27.629215Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715657:0 ProgressState no shards to create, do next state
2025-11-14T10:03:27.629220Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715657:0 2 -> 3
2025-11-14T10:03:27.629235Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:27.629361Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:964:2778], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:03:27.629367Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:03:27.629370Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T10:03:27.629686Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 1] Version: 4 }
2025-11-14T10:03:27.629693Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:03:27.629703Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 1 Version: 4 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:03:27.629715Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 1 Version: 4 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:03:27.629719Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T10:03:27.629724Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 1], version: 4
2025-11-14T10:03:27.629728Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 2
2025-11-14T10:03:27.629930Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:27.630054Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 2 }
2025-11-14T10:03:27.630061Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:03:27.630090Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 2 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:03:27.630099Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 2 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:03:27.630103Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T10:03:27.630107Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 2
2025-11-14T10:03:27.630111Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 3
2025-11-14T10:03:27.630121Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715657, ready parts: 0/1, is published: true
2025-11-14T10:03:27.630124Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:27.631243Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:27.631255Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T10:03:27.631346Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:03:27.631352Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:03:27.631358Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T10:03:27.631364Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715657:0 ProgressState, at schemeshard: 72057594046644480
2025-11-14T10:03:27.631369Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715657:0 3 -> 128
2025-11-14T10:03:27.631383Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:27.631441Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T10:03:27.631444Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:27.631996Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T10:03:27.632003Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:27.632467Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:27.632476Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T10:03:27.632499Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:03:27.632502Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:03:27.632508Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T10:03:27.632512Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose ProgressState, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T10:03:27.632518Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose ProgressState leave, operationId 281474976715657:0, at tablet# 72057594046644480
2025-11-14T10:03:27.632521Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:27.632527Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976715657 ready parts: 1/1
2025-11-14T10:03:27.633065Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoPropose send propose to coordinator: 72057594046316545 message:Transaction { AffectedSet { TabletId: 72057594046644480 Flags: 2 } ExecLevel: 0 TxId: 281474976715657 MinStep: 0 MaxStep: 18446744073709551615 IgnoreLowDiskSpace: true } CoordinatorID: 72057594046316545
2025-11-14T10:03:27.633641Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:27.633653Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715657:4294967295 from tablet: 72057594046644480 to tablet: 72057594046316545 cookie: 0:281474976715657 msg type: 269090816
2025-11-14T10:03:27.633676Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715657, partId: 4294967295, tablet: 72057594046316545
2025-11-14T10:03:27.633726Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:520:2432], Recipient [4:529:2441]: NKikimrTx.TEvProposeTransactionStatus Status: 16 StepId: 1000 TxId: 281474976715657
2025-11-14T10:03:27.633811Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:984:2798], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:27.633818Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:27.633821Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:03:27.633839Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124996, Sender [4:904:2725], Recipient [4:529:2441]: NKikimrScheme.TEvNotifyTxCompletion TxId: 281474976715657
2025-11-14T10:03:27.633843Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvNotifyTxCompletion
2025-11-14T10:03:27.633851Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NotifyTxCompletion operation in-flight, txId: 281474976715657, at schemeshard: 72057594046644480
2025-11-14T10:03:27.633855Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715657, ready parts: 0/1, is published: true
2025-11-14T10:03:27.633860Z node 4 :FLAT_TX_SCHEMESHARD INFO: NotifyTxCompletion transaction is registered, txId: 281474976715657, at schemeshard: 72057594046644480
2025-11-14T10:03:28.010545Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:520:2432], Recipient [4:529:2441]: NKikimrTx.TEvProposeTransactionStatus Status: 17 StepId: 1000 TxId: 281474976715657
2025-11-14T10:03:28.010657Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [4:750:2598], Recipient [4:529:2441]: {TEvPlanStep step# 1000 MediatorId# 72057594046382081 TabletID 72057594046644480}
2025-11-14T10:03:28.010664Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-11-14T10:03:28.010678Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1000, transactions count in step: 1, at schemeshard: 72057594046644480
2025-11-14T10:03:28.010708Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPlanStep Execute, message: Transactions { TxId: 281474976715657 AckTo { RawX1: 0 RawX2: 0 } } Step: 1000 MediatorID: 72057594046382081 TabletID: 72057594046644480, at schemeshard: 72057594046644480
2025-11-14T10:03:28.010728Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715657:0, at tablet# 72057594046644480
2025-11-14T10:03:28.010831Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715657:0 128 -> 240
2025-11-14T10:03:28.010846Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715657:0, at tablet# 72057594046644480
2025-11-14T10:03:28.010868Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:28.010892Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 1
2025-11-14T10:03:28.010904Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T10:03:28.010913Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715657:4294967295 from tablet: 72057594046644480 to tablet: 0 cookie: 0:281474976715657
2025-11-14T10:03:28.010919Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DoUpdateTenant no IsExternalSubDomainRoot, pathId: : [OwnerId: 72057594046644480, LocalPathId: 2], at schemeshard: 72057594046644480
2025-11-14T10:03:28.012555Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:28.012572Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1000
2025-11-14T10:03:28.012581Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T10:03:28.012627Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:03:28.012633Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:03:28.012725Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T10:03:28.012733Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 1]
2025-11-14T10:03:28.012792Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T10:03:28.012810Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T10:03:28.012816Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 1
2025-11-14T10:03:28.012822Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 2
2025-11-14T10:03:28.012937Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T10:03:28.012952Z node 4 :FLAT_TX_SCHEMESHARD INFO: [72057594046644480] TDone opId# 281474976715657:0 ProgressState
2025-11-14T10:03:28.012964Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:28.012969Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715657:0 progress is 1/1
2025-11-14T10:03:28.012974Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715657 ready parts: 1/1
2025-11-14T10:03:28.012979Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715657:0 progress is 1/1
2025-11-14T10:03:28.012982Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715657 ready parts: 1/1
2025-11-14T10:03:28.012987Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715657, ready parts: 1/1, is published: false
2025-11-14T10:03:28.012993Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715657 ready parts: 1/1
2025-11-14T10:03:28.012998Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976715657:0
2025-11-14T10:03:28.013003Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976715657:0
2025-11-14T10:03:28.013016Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 3
2025-11-14T10:03:28.013022Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication still in progress, tx: 281474976715657, publications: 2, subscribers: 1
2025-11-14T10:03:28.013026Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Publication details:  tx: 281474976715657, [OwnerId: 72057594046644480, LocalPathId: 1], 5
2025-11-14T10:03:28.013029Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Publication details:  tx: 281474976715657, [OwnerId: 72057594046644480, LocalPathId: 2], 3
2025-11-14T10:03:28.013210Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 1] Version: 5 }
2025-11-14T10:03:28.013220Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:03:28.013238Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 1 Version: 5 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:03:28.013249Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 1 Version: 5 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:03:28.013253Z node 4 :FLAT_TX_SCHEMESHARD INFO: Publication in-flight, count: 2, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T10:03:28.013276Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 1], version: 5
2025-11-14T10:03:28.013282Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 2
2025-11-14T10:03:28.013296Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:28.013543Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 3 }
2025-11-14T10:03:28.013553Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:03:28.013563Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 3 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:03:28.013576Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 3 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T10:03:28.013580Z node 4 :FLAT_TX_SCHEMESHARD INFO: Publication in-flight, count: 1, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T10:03:28.013584Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 3
2025-11-14T10:03:28.013589Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T10:03:28.013601Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication complete, notify & remove, at schemeshard: 72057594046644480, txId: 281474976715657, subscribers: 1
2025-11-14T10:03:28.013606Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Notify send TEvNotifyTxCompletionResult, at schemeshard: 72057594046644480, to actorId: [4:904:2725]
2025-11-14T10:03:28.013611Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:28.018407Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:28.018601Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T10:03:28.018611Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:28.018629Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T10:03:28.018633Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:28.018654Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [4:904:2725] msg type: 271124998 msg: NKikimrScheme.TEvNotifyTxCompletionResult TxId: 281474976715657 at schemeshard: 72057594046644480
2025-11-14T10:03:28.019238Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1013:2820], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:28.019250Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:28.019255Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:03:28.019275Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [4:1003:2817], Recipient [4:529:2441]: {TEvModifySchemeTransaction txid# 281474976715658 TabletId# 72057594046644480}
2025-11-14T10:03:28.019295Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-11-14T10:03:28.020043Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Execute, message: Transaction { WorkingDir: "/Root" OperationType: ESchemeOpAlterSubDomain SubDomain { PlanResolution: 10 Coordinators: 1 Mediators: 1 Name: "tenant" TimeCastBucketsPerMediator: 2 StoragePools { Name: "/Root:ssd" Kind: "ssd" } StoragePools { Name: "/Root:hdd" Kind: "hdd" } DatabaseQuotas { storage_quotas { unit_kind: "hdd" data_size_hard_quota: 1 } } } } TxId: 281474976715658 TabletId: 72057594046644480 PeerName: "" , at schemeshard: 72057594046644480
2025-11-14T10:03:28.020090Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TAlterSubDomain Propose, path: /Root/tenant, opId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:03:28.020141Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 1
2025-11-14T10:03:28.020151Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T10:03:28.020157Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 3
2025-11-14T10:03:28.020238Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976715658:1, propose status:StatusAccepted, reason: , at schemeshard: 72057594046644480
2025-11-14T10:03:28.020244Z node 4 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 281474976715658:0, at schemeshard:  72057594046644480
2025-11-14T10:03:28.020257Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:28.022482Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976715658, response: Status: StatusAccepted TxId: 281474976715658 SchemeshardId: 72057594046644480 PathId: 2, at schemeshard: 72057594046644480
2025-11-14T10:03:28.022543Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976715658, database: /Root, subject: , status: StatusAccepted, operation: ALTER DATABASE, path: /Root/tenant
2025-11-14T10:03:28.022551Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:28.022557Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T10:03:28.022617Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:03:28.022623Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:03:28.022632Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:03:28.022642Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715658:0 ProgressState, operation type: TxAlterSubDomain, at tablet# 72057594046644480
2025-11-14T10:03:28.022722Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715658:0 CreateRequest Event to Hive: 72057594037968897 msg:  Owner: 72057594046644480
OwnerIdx: 1
TabletType: Coordinator
ObjectDomain {
  SchemeShard: 72057594046644480
  PathId: 2
}
ObjectId: 2
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
AllowedDomains {
  SchemeShard: 72057594046644480
  PathId: 2
}
2025-11-14T10:03:28.022742Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715658:0 CreateRequest Event to Hive: 72057594037968897 msg:  Owner: 72057594046644480
OwnerIdx: 2
TabletType: Mediator
ObjectDomain {
  SchemeShard: 72057594046644480
  PathId: 2
}
ObjectId: 2
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
AllowedDomains {
  SchemeShard: 72057594046644480
  PathId: 2
}
2025-11-14T10:03:28.022748Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:28.022822Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1013:2820], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:03:28.022827Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:03:28.022831Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T10:03:28.024457Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:28.024477Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:1 msg type: 268697601
2025-11-14T10:03:28.024518Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:2 msg type: 268697601
2025-11-14T10:03:28.024532Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 0, tablet: 72057594037968897
2025-11-14T10:03:28.024539Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:1, partId: 0
2025-11-14T10:03:28.024542Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:2, partId: 0
2025-11-14T10:03:28.024680Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1020:2827], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72057594037968897 Status: OK ServerId: [4:1021:2828] Leader: 1 Dead: 0 Generation: 2 VersionInfo:  }
2025-11-14T10:03:28.024688Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T10:03:28.024693Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72057594037968897, status: OK, at schemeshard: 72057594046644480
2025-11-14T10:03:28.631757Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1302:2843], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:28.631776Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:28.631782Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:03:28.636346Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122945, Sender [5:1259:2343], Recipient [4:1302:2843]
2025-11-14T10:03:28.636366Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvDescribeScheme
2025-11-14T10:03:28.637215Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1316:2848], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:28.637229Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:28.637235Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:03:28.637346Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [4:1293:2839], Recipient [4:529:2441]: {TEvModifySchemeTransaction txid# 281474976715659 TabletId# 72057594046644480}
2025-11-14T10:03:28.637353Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-11-14T10:03:28.638636Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Execute, message: Transaction { WorkingDir: "/Root/tenant" OperationType: ESchemeOpCreateTable CreateTable { Name: "table" Columns { Name: "Key" Type: "Uint32" NotNull: false } Columns { Name: "Value" Type: "Utf8" FamilyName: "hdd" NotNull: false } KeyColumnNames: "Key" PartitionConfig { ColumnFamilies { ColumnCodec: ColumnCodecPlain StorageConfig { SysLog { PreferredPoolKind: "ssd" } Log { PreferredPoolKind: "ssd" } Data { PreferredPoolKind: "ssd" AllowOtherKinds: false } } } ColumnFamilies { Name: "hdd" ColumnCodec: ColumnCodecLZ4 StorageConfig { Data { PreferredPoolKind: "hdd" AllowOtherKinds: false } } } } Temporary: false } } TxId: 281474976715659 TabletId: 72057594046644480 PeerName: "" , at schemeshard: 72057594046644480
2025-11-14T10:03:28.638722Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TCreateTable Propose, path: /Root/tenant/table, opId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:03:28.638743Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable Propose, path: /Root/tenant/table, opId: 281474976715659:0, schema: Name: "table" Columns { Name: "Key" Type: "Uint32" NotNull: false } Columns { Name: "Value" Type: "Utf8" FamilyName: "hdd" NotNull: false } KeyColumnNames: "Key" PartitionConfig { ColumnFamilies { ColumnCodec: ColumnCodecPlain StorageConfig { SysLog { PreferredPoolKind: "ssd" } Log { PreferredPoolKind: "ssd" } Data { PreferredPoolKind: "ssd" AllowOtherKinds: false } } } ColumnFamilies { Name: "hdd" ColumnCodec: ColumnCodecLZ4 StorageConfig { Data { PreferredPoolKind: "hdd" AllowOtherKinds: false } } } } Temporary: false, at schemeshard: 72057594046644480
2025-11-14T10:03:28.638858Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: AttachChild: child attached as only one child to the parent, parent id: [OwnerId: 72057594046644480, LocalPathId: 2], parent name: tenant, child name: table, child id: [OwnerId: 72057594046644480, LocalPathId: 3], at schemeshard: 72057594046644480
2025-11-14T10:03:28.638873Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 0
2025-11-14T10:03:28.638881Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 1
2025-11-14T10:03:28.638901Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new path created for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 2
2025-11-14T10:03:28.638908Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 1 -> 2
2025-11-14T10:03:28.639111Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TCreateTable Propose creating new table opId# 281474976715659:0 path# /Root/tenant/table pathId# [OwnerId: 72057594046644480, LocalPathId: 3] schemeshard# 72057594046644480 tx# WorkingDir: "/Root/tenant"
OperationType: ESchemeOpCreateTable
CreateTable {
  Name: "table"
  Columns {
    Name: "Key"
    Type: "Uint32"
    NotNull: false
  }
  Columns {
    Name: "Value"
    Type: "Utf8"
    FamilyName: "hdd"
    NotNull: false
  }
  KeyColumnNames: "Key"
  PartitionConfig {
    ColumnFamilies {
      ColumnCodec: ColumnCodecPlain
      StorageConfig {
        SysLog {
          PreferredPoolKind: "ssd"
        }
        Log {
          PreferredPoolKind: "ssd"
        }
        Data {
          PreferredPoolKind: "ssd"
          AllowOtherKinds: false
        }
      }
    }
    ColumnFamilies {
      Name: "hdd"
      ColumnCodec: ColumnCodecLZ4
      StorageConfig {
        Data {
          PreferredPoolKind: "hdd"
          AllowOtherKinds: false
        }
      }
    }
  }
  Temporary: false
}
FailOnExist: false
2025-11-14T10:03:28.639134Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976715659:1, propose status:StatusAccepted, reason: , at schemeshard: 72057594046644480
2025-11-14T10:03:28.639142Z node 4 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976715659:0, at schemeshard:  72057594046644480
2025-11-14T10:03:28.639156Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:28.639165Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T10:03:28.639174Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 3
2025-11-14T10:03:28.640442Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976715659, response: Status: StatusAccepted TxId: 281474976715659 SchemeshardId: 72057594046644480 PathId: 3, at schemeshard: 72057594046644480
2025-11-14T10:03:28.640485Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976715659, database: /Root/tenant, subject: , status: StatusAccepted, operation: CREATE TABLE, path: /Root/tenant/table
2025-11-14T10:03:28.640495Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:28.640503Z node 4 :FLAT_TX_SCHEMESHARD INFO: Delay activating, operation part: 281474976715659:0, there is await operations num 1
2025-11-14T10:03:28.640581Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T10:03:28.640590Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T10:03:28.640626Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 3]
2025-11-14T10:03:28.640645Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T10:03:28.640650Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 2
2025-11-14T10:03:28.640656Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 3
2025-11-14T10:03:28.640804Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1316:2848], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:03:28.640814Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:03:28.640821Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T10:03:28.640965Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 4 }
2025-11-14T10:03:28.640975Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:03:28.640989Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 4 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:03:28.641002Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 4 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:03:28.641007Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T10:03:28.641031Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 4
2025-11-14T10:03:28.641037Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 6
2025-11-14T10:03:28.641063Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:28.641183Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1332:2853], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:28.641192Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:28.641197Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:03:28.641254Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124996, Sender [4:1292:2838], Recipient [4:529:2441]: NKikimrScheme.TEvNotifyTxCompletion TxId: 281474976715659
2025-11-14T10:03:28.641261Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvNotifyTxCompletion
2025-11-14T10:03:28.641271Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NotifyTxCompletion operation in-flight, txId: 281474976715659, at schemeshard: 72057594046644480
2025-11-14T10:03:28.641277Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 0/1, is published: false
2025-11-14T10:03:28.641283Z node 4 :FLAT_TX_SCHEMESHARD INFO: NotifyTxCompletion transaction is registered, txId: 281474976715659, at schemeshard: 72057594046644480
2025-11-14T10:03:28.641334Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 3] Version: 1 }
2025-11-14T10:03:28.641342Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:03:28.641351Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 3 Version: 1 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:03:28.641360Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 3 Version: 1 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:03:28.641365Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T10:03:28.641372Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], version: 1
2025-11-14T10:03:28.641377Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 4
2025-11-14T10:03:28.641390Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 0/1, is published: true
2025-11-14T10:03:28.641394Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:28.642957Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T10:03:28.642971Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:28.643112Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T10:03:28.643118Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:28.643487Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(5, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-14T10:03:28.643504Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(5, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-14T10:03:28.678685Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [4:535:2446], Recipient [4:529:2441]: {EvCreateTabletReply Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897}
2025-11-14T10:03:28.678711Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-11-14T10:03:28.678743Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72057594046644480 message: Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897
2025-11-14T10:03:28.678754Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:1, partId: 0
2025-11-14T10:03:28.678784Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897
2025-11-14T10:03:28.678793Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, at tabletId: 72057594046644480
2025-11-14T10:03:28.678800Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, message: Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897
2025-11-14T10:03:28.678825Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:28.678833Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:1
2025-11-14T10:03:28.678912Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [4:535:2446], Recipient [4:529:2441]: {EvCreateTabletReply Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897}
2025-11-14T10:03:28.678918Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-11-14T10:03:28.678924Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72057594046644480 message: Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897
2025-11-14T10:03:28.678929Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:2, partId: 0
2025-11-14T10:03:28.678938Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897
2025-11-14T10:03:28.678941Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, at tabletId: 72057594046644480
2025-11-14T10:03:28.678947Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, message: Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897
2025-11-14T10:03:28.678956Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715658:0 2 -> 3
2025-11-14T10:03:28.678972Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:28.678976Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:2
2025-11-14T10:03:28.679003Z node 4 :HIVE WARN: HIVE#72057594037968897 Handle TEvInterconnect::TEvNodeConnected, NodeId 5 Cookie 5
2025-11-14T10:03:28.679796Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(5, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-11-14T10:03:28.680225Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:03:28.680238Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:28.680303Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:03:28.680307Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:28.680312Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T10:03:28.680332Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:03:28.680337Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:03:28.680345Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:03:28.680351Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715658:0 ProgressState, at schemeshard: 72057594046644480
2025-11-14T10:03:28.680367Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send configure request to coordinator/mediator: 72075186224037888 opId: 281474976715658:0 schemeshard: 72057594046644480
2025-11-14T10:03:28.680374Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send configure request to coordinator/mediator: 72075186224037889 opId: 281474976715658:0 schemeshard: 72057594046644480
2025-11-14T10:03:28.680379Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:28.680785Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:28.680799Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037888 cookie: 72057594046644480:1 msg type: 272564224
2025-11-14T10:03:28.680822Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037889 cookie: 72057594046644480:2 msg type: 272564224
2025-11-14T10:03:28.680839Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 0, tablet: 72075186224037888
2025-11-14T10:03:28.680843Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 0, tablet: 72075186224037889
2025-11-14T10:03:28.749589Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [4:535:2446], Recipient [4:529:2441]: {EvTabletCreationResult Status: OK TabletID: 72075186224037888}
2025-11-14T10:03:28.749618Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [4:535:2446], Recipient [4:529:2441]: {EvTabletCreationResult Status: OK TabletID: 72075186224037889}
2025-11-14T10:03:28.797028Z node 4 :TX_CONVEYOR ERROR: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-11-14T10:03:28.808369Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1351:2872], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72075186224037888 Status: OK ServerId: [5:1448:2402] Leader: 1 Dead: 0 Generation: 1 VersionInfo:  }
2025-11-14T10:03:28.808395Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T10:03:28.808402Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037888, status: OK, at schemeshard: 72057594046644480
2025-11-14T10:03:28.808432Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:28.808437Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:28.808495Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1352:2873], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72075186224037889 Status: OK ServerId: [5:1449:2403] Leader: 1 Dead: 0 Generation: 1 VersionInfo:  }
2025-11-14T10:03:28.808500Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T10:03:28.808503Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037889, status: OK, at schemeshard: 72057594046644480
2025-11-14T10:03:28.810218Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 272564225, Sender [5:1382:2370], Recipient [4:529:2441]
2025-11-14T10:03:28.810237Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSubDomain::TEvConfigureStatus
2025-11-14T10:03:28.810254Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715658, tablet: 72075186224037888, partId: 0
2025-11-14T10:03:28.810297Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: SUCCESS OnTabletId: 72075186224037888
2025-11-14T10:03:28.810313Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715658:0 HandleReply TEvConfigureStatus operationId:281474976715658:0 at schemeshard:72057594046644480
2025-11-14T10:03:28.810323Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TConfigureParts operationId# 281474976715658:0 Got OK TEvConfigureStatus from  tablet# 72075186224037888 shardIdx# 72057594046644480:1 at schemeshard# 72057594046644480
2025-11-14T10:03:28.810329Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:28.810337Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037888 cookie: 72057594046644480:1
2025-11-14T10:03:28.811368Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:03:28.811382Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:28.811445Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 272564225, Sender [5:1384:2371], Recipient [4:529:2441]
2025-11-14T10:03:28.811451Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSubDomain::TEvConfigureStatus
2025-11-14T10:03:28.811461Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715658, tablet: 72075186224037889, partId: 0
2025-11-14T10:03:28.811481Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: SUCCESS OnTabletId: 72075186224037889
2025-11-14T10:03:28.811492Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715658:0 HandleReply TEvConfigureStatus operationId:281474976715658:0 at schemeshard:72057594046644480
2025-11-14T10:03:28.811499Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TConfigureParts operationId# 281474976715658:0 Got OK TEvConfigureStatus from  tablet# 72075186224037889 shardIdx# 72057594046644480:2 at schemeshard# 72057594046644480
2025-11-14T10:03:28.811505Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715658:0 3 -> 128
2025-11-14T10:03:28.811524Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:28.811530Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037889 cookie: 72057594046644480:2
2025-11-14T10:03:28.812585Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:03:28.812598Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:28.812604Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T10:03:28.812636Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:03:28.812641Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:03:28.812651Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:03:28.812657Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose ProgressState, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:03:28.812663Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose ProgressState leave, operationId 281474976715658:0, at tablet# 72057594046644480
2025-11-14T10:03:28.812667Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:28.812674Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976715658 ready parts: 1/1
2025-11-14T10:03:28.812766Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoPropose send propose to coordinator: 72057594046316545 message:Transaction { AffectedSet { TabletId: 72057594046644480 Flags: 2 } ExecLevel: 0 TxId: 281474976715658 MinStep: 0 MaxStep: 18446744073709551615 IgnoreLowDiskSpace: true } CoordinatorID: 72057594046316545
2025-11-14T10:03:28.813223Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:28.813239Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715658:4294967295 from tablet: 72057594046644480 to tablet: 72057594046316545 cookie: 0:281474976715658 msg type: 269090816
2025-11-14T10:03:28.813263Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 4294967295, tablet: 72057594046316545
2025-11-14T10:03:28.813326Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:520:2432], Recipient [4:529:2441]: NKikimrTx.TEvProposeTransactionStatus Status: 16 StepId: 1500 TxId: 281474976715658
2025-11-14T10:03:29.084552Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:520:2432], Recipient [4:529:2441]: NKikimrTx.TEvProposeTransactionStatus Status: 17 StepId: 1500 TxId: 281474976715658
2025-11-14T10:03:29.084695Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [4:750:2598], Recipient [4:529:2441]: {TEvPlanStep step# 1500 MediatorId# 72057594046382081 TabletID 72057594046644480}
2025-11-14T10:03:29.084705Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-11-14T10:03:29.084721Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1500, transactions count in step: 1, at schemeshard: 72057594046644480
2025-11-14T10:03:29.084747Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPlanStep Execute, message: Transactions { TxId: 281474976715658 AckTo { RawX1: 0 RawX2: 0 } } Step: 1500 MediatorID: 72057594046382081 TabletID: 72057594046644480, at schemeshard: 72057594046644480
2025-11-14T10:03:29.084760Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715658:0, at tablet# 72057594046644480
2025-11-14T10:03:29.084856Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715658:0 128 -> 240
2025-11-14T10:03:29.084868Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715658:0, at tablet# 72057594046644480
2025-11-14T10:03:29.084892Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:29.084909Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T10:03:29.084923Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:4294967295 from tablet: 72057594046644480 to tablet: 0 cookie: 0:281474976715658
2025-11-14T10:03:29.084930Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DoUpdateTenant no IsExternalSubDomainRoot, pathId: : [OwnerId: 72057594046644480, LocalPathId: 2], at schemeshard: 72057594046644480
2025-11-14T10:03:29.085800Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.085815Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1500
2025-11-14T10:03:29.085823Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T10:03:29.085975Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:03:29.085984Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:03:29.086004Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T10:03:29.086011Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715658, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T10:03:29.086147Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T10:03:29.086158Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715658, path id: 2
2025-11-14T10:03:29.086295Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T10:03:29.086307Z node 4 :FLAT_TX_SCHEMESHARD INFO: [72057594046644480] TDone opId# 281474976715658:0 ProgressState
2025-11-14T10:03:29.086319Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:29.086325Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715658:0 progress is 1/1
2025-11-14T10:03:29.086330Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715658 ready parts: 1/1
2025-11-14T10:03:29.086339Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715658:0 progress is 1/1
2025-11-14T10:03:29.086342Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715658 ready parts: 1/1
2025-11-14T10:03:29.086348Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715658, ready parts: 1/1, is published: false
2025-11-14T10:03:29.086355Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715658 ready parts: 1/1
2025-11-14T10:03:29.086361Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Remove dependency, parent tx: 281474976715658, dependent tx: 281474976715659
2025-11-14T10:03:29.086377Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976715658:0
2025-11-14T10:03:29.086381Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976715658:0
2025-11-14T10:03:29.086409Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 6
2025-11-14T10:03:29.086416Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication still in progress, tx: 281474976715658, publications: 1, subscribers: 0
2025-11-14T10:03:29.086437Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Publication details:  tx: 281474976715658, [OwnerId: 72057594046644480, LocalPathId: 2], 5
2025-11-14T10:03:29.086748Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 5 }
2025-11-14T10:03:29.086760Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:03:29.086778Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 5 PathOwnerId: 72057594046644480, cookie: 281474976715658
2025-11-14T10:03:29.086791Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 5 PathOwnerId: 72057594046644480, cookie: 281474976715658
2025-11-14T10:03:29.086796Z node 4 :FLAT_TX_SCHEMESHARD INFO: Publication in-flight, count: 1, at schemeshard: 72057594046644480, txId: 281474976715658
2025-11-14T10:03:29.086802Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715658, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 5
2025-11-14T10:03:29.086807Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T10:03:29.086825Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication complete, notify & remove, at schemeshard: 72057594046644480, txId: 281474976715658, subscribers: 0
2025-11-14T10:03:29.086828Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:29.088402Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.088419Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T10:03:29.088562Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:03:29.088573Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:03:29.088583Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:03:29.088593Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715659:0 ProgressState, operation type: TxCreateTable, at tablet# 72057594046644480
2025-11-14T10:03:29.088679Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715659:0 CreateRequest Event to Hive: 72057594037968897 msg:  Owner: 72057594046644480
OwnerIdx: 3
TabletType: DataShard
ObjectDomain {
  SchemeShard: 72057594046644480
  PathId: 2
}
ObjectId: 3
BindedChannels {
  StoragePoolName: "/Root:ssd"
  StoragePoolKind: "ssd"
}
BindedChannels {
  StoragePoolName: "/Root:ssd"
  StoragePoolKind: "ssd"
}
BindedChannels {
  StoragePoolName: "/Root:hdd"
  StoragePoolKind: "hdd"
}
AllowedDomains {
  SchemeShard: 72057594046644480
  PathId: 2
}
2025-11-14T10:03:29.088691Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:29.089273Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715658
2025-11-14T10:03:29.089285Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.089627Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.089642Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:3 msg type: 268697601
2025-11-14T10:03:29.089672Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715659, partId: 0, tablet: 72057594037968897
2025-11-14T10:03:29.089679Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976715659, shardIdx: 72057594046644480:3, partId: 0
2025-11-14T10:03:29.114819Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [4:535:2446], Recipient [4:529:2441]: {EvCreateTabletReply Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897}
2025-11-14T10:03:29.114840Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-11-14T10:03:29.114863Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72057594046644480 message: Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897
2025-11-14T10:03:29.114872Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976715659, shardIdx: 72057594046644480:3, partId: 0
2025-11-14T10:03:29.114893Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480, message: Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897
2025-11-14T10:03:29.114900Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715659:0 HandleReply TEvCreateTabletReply, at tabletId: 72057594046644480
2025-11-14T10:03:29.114905Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715659:0 HandleReply TEvCreateTabletReply, message: Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897
2025-11-14T10:03:29.114933Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 2 -> 3
2025-11-14T10:03:29.114947Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:29.114954Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:3
2025-11-14T10:03:29.115776Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:03:29.115788Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.115794Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T10:03:29.115835Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:03:29.115839Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:03:29.115846Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:03:29.115851Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TConfigureParts operationId# 281474976715659:0 ProgressState at tabletId# 72057594046644480
2025-11-14T10:03:29.115875Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable TConfigureParts operationId# 281474976715659:0 ProgressState Propose modify scheme on datashard datashardId: 72075186224037890 seqNo: 2:1
2025-11-14T10:03:29.116079Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable TConfigureParts operationId# 281474976715659:0 ProgressState Propose modify scheme on datashard datashardId: 72075186224037890 message: TxKind: TX_KIND_SCHEME SourceDeprecated { RawX1: 529 RawX2: 17179871625 } TxBody: "\n\211\005\n\005table\020\003\032\r\n\003Key\030\002 \001(\000@\000\032\020\n\005Value\030\200$ \002(\001@\000(\001:\243\004\022\253\003\010\200\200\200\002\020\254\002\030\364\003 \200\200\200\010(\0000\200\200\200 8\200\200\200\010@\2008H\000RX\010\000\020\000\030\010 \010(\200\200\200@0\377\377\377\377\0178\001B$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionJ\017compaction_gen1P\nX\200\200\001`nh\000p\000Rb\010\001\020\200\200\200\024\030\005 \020(\200\200\200\200\0020\377\377\377\377\0178\000B$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionJ\017compaction_gen2P\nX\200\200\001`nh\200\200\200\004p\200\200\200\004Rc\010\002\020\200\200\200\310\001\030\005 \020(\200\200\200\200@0\377\377\377\377\0178\000B$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionJ\017compaction_gen3P\nX\200\200\001`nh\200\200\200(p\200\200\200(X\001`\005j$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionr\017compaction_gen0z\017compaction_gen0\202\001\004scan\210\001\200\200\200\010\220\001\364\003\230\0012\270\001\2008\300\001\006R\002\020\001b\035\010\0000\000J\027\n\005\n\003ssd\022\005\n\003ssd\032\007\n\003ssd\020\000b\026\010\001\020\001*\003hdd0\001J\t\032\007\n\003hdd\020\000\212\001&\010\000\022\004\010\001\020\000\022\004\010\002\020\001\022\004\010\003\020\001\032\004\010\001\020\000\032\004\010\002\020\001\032\004\010\003\020\001\212\001\016\010\001\022\004\010\003\020\002\032\004\010\003\020\002J\022/Root/tenant/table\242\001\006\001\000\000\000\000\200\252\001\000\260\001\001\270\001\000\210\002\001\222\002\013\t\000\001\205\000\000\000\000\001\020\003:\004\010\002\020\001" TxId: 281474976715659 ExecLevel: 0 Flags: 0 SchemeShardId: 72057594046644480 ProcessingParams { Version: 2 PlanResolution: 10 Coordinators: 72075186224037888 TimeCastBucketsPerMediator: 2 Mediators: 72075186224037889 } SubDomainPathId: 2
2025-11-14T10:03:29.116100Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:29.116716Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.116729Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72075186224037890 cookie: 72057594046644480:3 msg type: 269549568
2025-11-14T10:03:29.116757Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715659, partId: 0, tablet: 72075186224037890
2025-11-14T10:03:29.183354Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [4:535:2446], Recipient [4:529:2441]: {EvTabletCreationResult Status: OK TabletID: 72075186224037890}
2025-11-14T10:03:29.214551Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1520:2941], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72075186224037890 Status: OK ServerId: [5:1570:2450] Leader: 1 Dead: 0 Generation: 1 VersionInfo:  }
2025-11-14T10:03:29.214579Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T10:03:29.214587Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037890, status: OK, at schemeshard: 72057594046644480
2025-11-14T10:03:29.230593Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269550080, Sender [5:1537:2431], Recipient [4:529:2441]
2025-11-14T10:03:29.230624Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvProposeTransactionResult
2025-11-14T10:03:29.231337Z 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: 95 } }
2025-11-14T10:03:29.231359Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715659, tablet: 72075186224037890, partId: 0
2025-11-14T10:03:29.231400Z 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: 95 } }
2025-11-14T10:03:29.231409Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TConfigureParts operationId# 281474976715659:0 HandleReply TEvProposeTransactionResult at tabletId# 72057594046644480
2025-11-14T10:03:29.231419Z 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: 95 } }
2025-11-14T10:03:29.231425Z node 4 :FLAT_TX_SCHEMESHARD INFO: TEvProposeTransactionResult at tablet: 72057594046644480
2025-11-14T10:03:29.231458Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: CollectProposeTransactionResults accept TEvProposeTransactionResult, shard: 72075186224037890, shardIdx: 72057594046644480:3, operationId: 281474976715659:0, left await: 0, at schemeshard: 72057594046644480
2025-11-14T10:03:29.231464Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 3 -> 128
2025-11-14T10:03:29.231475Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:29.231484Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72075186224037890 cookie: 72057594046644480:3
2025-11-14T10:03:29.232442Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:03:29.232456Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.232463Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T10:03:29.232518Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:03:29.232525Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:03:29.232537Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:03:29.232544Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TPropose operationId# 281474976715659:0 HandleReply ProgressState at tablet: 72057594046644480
2025-11-14T10:03:29.232553Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:29.232562Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976715659 ready parts: 1/1
2025-11-14T10:03:29.232602Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoPropose send propose to coordinator: 72075186224037888 message:Transaction { AffectedSet { TabletId: 72057594046644480 Flags: 2 } AffectedSet { TabletId: 72075186224037890 Flags: 2 } ExecLevel: 0 TxId: 281474976715659 MinStep: 1 MaxStep: 18446744073709551615 IgnoreLowDiskSpace: true } CoordinatorID: 72075186224037888
2025-11-14T10:03:29.233307Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.233321Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715659:4294967295 from tablet: 72057594046644480 to tablet: 72075186224037888 cookie: 0:281474976715659 msg type: 269090816
2025-11-14T10:03:29.233350Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715659, partId: 4294967295, tablet: 72075186224037888
2025-11-14T10:03:29.233726Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [5:1382:2370], Recipient [4:529:2441]
2025-11-14T10:03:29.234401Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [5:1382:2370], Recipient [4:529:2441]
2025-11-14T10:03:29.234585Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1593:2955], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:29.234592Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:29.234596Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:03:29.234798Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [5:1466:2412], Recipient [4:1593:2955]
2025-11-14T10:03:29.234805Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-11-14T10:03:29.234821Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1560, transactions count in step: 1, at schemeshard: 72057594046644480
2025-11-14T10:03:29.234845Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPlanStep Execute, message: Transactions { TxId: 281474976715659 AckTo { RawX1: 0 RawX2: 0 } } Step: 1560 MediatorID: 72075186224037889 TabletID: 72057594046644480, at schemeshard: 72057594046644480
2025-11-14T10:03:29.234856Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TPropose operationId# 281474976715659:0 HandleReply TEvOperationPlan at tablet: 72057594046644480, stepId: 1560
2025-11-14T10:03:29.234891Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 128 -> 129
2025-11-14T10:03:29.234905Z node 4 :FLAT_TX_SCHEMESHARD TRACE: NTableState::TProposedWaitParts operationId# 281474976715659:0 Constructed
2025-11-14T10:03:29.234915Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:29.234930Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 4
2025-11-14T10:03:29.234943Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 3
2025-11-14T10:03:29.234949Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715659:4294967295 from tablet: 72057594046644480 to tablet: 0 cookie: 0:281474976715659
2025-11-14T10:03:29.237042Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.237056Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1560
2025-11-14T10:03:29.237065Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T10:03:29.237337Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:03:29.237348Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:03:29.237368Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T10:03:29.237374Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T10:03:29.237427Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 3]
2025-11-14T10:03:29.237495Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T10:03:29.237501Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 2
2025-11-14T10:03:29.237510Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 3
2025-11-14T10:03:29.237637Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:03:29.237646Z node 4 :FLAT_TX_SCHEMESHARD INFO: NTableState::TProposedWaitParts operationId# 281474976715659:0 ProgressState at tablet: 72057594046644480
2025-11-14T10:03:29.237666Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:29.237959Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 6 }
2025-11-14T10:03:29.237970Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:03:29.237987Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 6 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:03:29.237998Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 6 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:03:29.238003Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T10:03:29.238008Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 6
2025-11-14T10:03:29.238014Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T10:03:29.238030Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:29.238218Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 3] Version: 3 }
2025-11-14T10:03:29.238228Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:03:29.238237Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 3 Version: 3 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:03:29.238247Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 3 Version: 3 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T10:03:29.238251Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T10:03:29.238255Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], version: 3
2025-11-14T10:03:29.238260Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 4
2025-11-14T10:03:29.238273Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 0/1, is published: true
2025-11-14T10:03:29.238277Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:29.238932Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.239847Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T10:03:29.239859Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.239930Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T10:03:29.239935Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.240259Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269550080, Sender [5:1537:2431], Recipient [4:529:2441]
2025-11-14T10:03:29.240269Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvProposeTransactionResult
2025-11-14T10:03:29.240310Z 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: 4 DomainCoordinators: 72075186224037888 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 392 } }
2025-11-14T10:03:29.240317Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715659, tablet: 72075186224037890, partId: 0
2025-11-14T10:03:29.240338Z 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: 4 DomainCoordinators: 72075186224037888 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 392 } }
2025-11-14T10:03:29.240352Z 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: 4 DomainCoordinators: 72075186224037888 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 392 } }
2025-11-14T10:03:29.240358Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:29.243014Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1621:2969], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:29.243029Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:29.243035Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:03:29.243641Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:03:29.243653Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.243817Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269551620, Sender [5:1537:2431], Recipient [4:1621:2969]
2025-11-14T10:03:29.243825Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvSchemaChanged
2025-11-14T10:03:29.243868Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvSchemaChanged, tabletId: 72057594046644480, at schemeshard: 72057594046644480, message: Source { RawX1: 1537 RawX2: 21474838911 } Origin: 72075186224037890 State: 2 TxId: 281474976715659 Step: 0 Generation: 1
2025-11-14T10:03:29.243876Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715659, tablet: 72075186224037890, partId: 0
2025-11-14T10:03:29.243894Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvSchemaChanged> execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480, message: Source { RawX1: 1537 RawX2: 21474838911 } Origin: 72075186224037890 State: 2 TxId: 281474976715659 Step: 0 Generation: 1
2025-11-14T10:03:29.243903Z node 4 :FLAT_TX_SCHEMESHARD INFO: NTableState::TProposedWaitParts operationId# 281474976715659:0 HandleReply TEvDataShard::TEvSchemaChanged at tablet: 72057594046644480
2025-11-14T10:03:29.243912Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NTableState::TProposedWaitParts operationId# 281474976715659:0 HandleReply TEvDataShard::TEvSchemaChanged at tablet: 72057594046644480 message: Source { RawX1: 1537 RawX2: 21474838911 } Origin: 72075186224037890 State: 2 TxId: 281474976715659 Step: 0 Generation: 1
2025-11-14T10:03:29.243924Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: CollectSchemaChanged accept TEvDataShard::TEvSchemaChanged, operationId: 281474976715659:0, shardIdx: 72057594046644480:3, shard: 72075186224037890, left await: 0, txState.State: ProposedWaitParts, txState.ReadyForNotifications: 1, at schemeshard: 72057594046644480
2025-11-14T10:03:29.243929Z node 4 :FLAT_TX_SCHEMESHARD INFO: all shard schema changes has been received, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:03:29.243934Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: send schema changes ack message, operation: 281474976715659:0, datashard: 72075186224037890, at schemeshard: 72057594046644480
2025-11-14T10:03:29.243942Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 129 -> 240
2025-11-14T10:03:29.243973Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:29.244510Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvSchemaChanged> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:03:29.244520Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.244529Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T10:03:29.244563Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [5:1537:2431] msg type: 269552132 msg: NKikimrTxDataShard.TEvSchemaChangedResult TxId: 281474976715659 at schemeshard: 72057594046644480
2025-11-14T10:03:29.244603Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T10:03:29.244609Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T10:03:29.244616Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T10:03:29.244624Z node 4 :FLAT_TX_SCHEMESHARD INFO: [72057594046644480] TDone opId# 281474976715659:0 ProgressState
2025-11-14T10:03:29.244635Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T10:03:29.244642Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715659:0 progress is 1/1
2025-11-14T10:03:29.244647Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715659 ready parts: 1/1
2025-11-14T10:03:29.244653Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715659:0 progress is 1/1
2025-11-14T10:03:29.244656Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715659 ready parts: 1/1
2025-11-14T10:03:29.244662Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 1/1, is published: true
2025-11-14T10:03:29.244674Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoNotify send TEvNotifyTxCompletionResult to actorId: [4:1292:2838] message: TxId: 281474976715659
2025-11-14T10:03:29.244681Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715659 ready parts: 1/1
2025-11-14T10:03:29.244688Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976715659:0
2025-11-14T10:03:29.244693Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976715659:0
2025-11-14T10:03:29.244723Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 3
2025-11-14T10:03:29.245229Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.245249Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [4:1292:2838] msg type: 271124998 msg: NKikimrScheme.TEvNotifyTxCompletionResult TxId: 281474976715659 at schemeshard: 72057594046644480
2025-11-14T10:03:29.245355Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1332:2853], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:03:29.245362Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:03:29.245366Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T10:03:29.265533Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715660. Ctx: { TraceId: 01ka0x3tjy52jef9vhqf6fw0wy, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=YmY2NjE4NzktNjJmMWMyYmUtODNlZmJlYjctYzUxYTY5NTM=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-11-14T10:03:29.284381Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1621:2969], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:03:29.284409Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T10:03:29.284415Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T10:03:29.284899Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1654:2994], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:29.284918Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:29.284923Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:03:29.284973Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122945, Sender [4:1651:2991], Recipient [4:529:2441]: NKikimrSchemeOp.TDescribePath Path: "/Root/tenant/table" Options { ShowPrivateTable: true }
2025-11-14T10:03:29.284979Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvDescribeScheme
2025-11-14T10:03:29.290978Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1672:3001], Recipient [4:529:2441]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:29.291001Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T10:03:29.291007Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T10:03:29.291264Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [5:1537:2431], Recipient [4:1672:3001]
2025-11-14T10:03:29.291273Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-11-14T10:03:29.291316Z node 4 :FLAT_TX_SCHEMESHARD INFO: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] state 'Ready' dataSize 75 rowCount 1 cpuUsage 0
2025-11-14T10:03:29.291373Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] raw table stats:
DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1523 LastUpdateTime: 1523 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0
2025-11-14T10:03:29.291382Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.100000s, queue# 1
2025-11-14T10:03:29.404059Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T10:03:29.404090Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T10:03:29.404098Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 1
2025-11-14T10:03:29.404117Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 1
2025-11-14T10:03:29.404124Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.000000s, queue# 1
2025-11-14T10:03:29.404167Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: PersistSingleStats for pathId 3 shard idx 72057594046644480:3 data size 75 row count 1
2025-11-14T10:03:29.404190Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxStoreTableStats.PersistSingleStats: main stats from datashardId(TabletID)=72075186224037890 maps to shardIdx: 72057594046644480:3 followerId=0, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], pathId map=table, is column=0, is olap=0
2025-11-14T10:03:29.404202Z node 4 :FLAT_TX_SCHEMESHARD INFO: Add stats from shard with datashardId(TabletID)=72075186224037890 followerId=0, pathId 3: RowCount 1, DataSize 75
2025-11-14T10:03:29.404207Z node 4 :FLAT_TX_SCHEMESHARD TRACE: BuildStatsForCollector: datashardId 72075186224037890, followerId 0
2025-11-14T10:03:29.404227Z node 4 :FLAT_TX_SCHEMESHARD TRACE: [BackgroundCompaction] [Update] Skipped shard# 72057594046644480:3 with partCount# 1, rowCount# 1, searchHeight# 1, lastFullCompaction# 1970-01-01T00:00:01.000000Z at schemeshard 72057594046644480
2025-11-14T10:03:29.404359Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T10:03:29.404367Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 0, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T10:03:29.406851Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:29.406887Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T10:03:29.406895Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 0, path id: 2
2025-11-14T10:03:29.407199Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 7 }
2025-11-14T10:03:29.407209Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:03:29.407233Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 7 PathOwnerId: 72057594046644480, cookie: 0
2025-11-14T10:03:29.419835Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T10:03:29.419868Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T10:03:29.419876Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-11-14T10:03:29.674311Z node 5 :TX_CONVEYOR ERROR: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-11-14T10:03:29.760098Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:29.760125Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:29.760153Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:29.760159Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:30.420997Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:30.421027Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:30.421050Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:30.421055Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:30.947297Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:30.947328Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:30.947358Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:30.947364Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:31.472655Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:31.472680Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:31.472708Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:31.472713Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:32.056446Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:32.056478Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:32.056509Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:32.056514Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
Captured TEvDataShard::TEvPeriodicTableStats DatashardId: 72075186224037890 TableLocalId: 3 Generation: 1 Round: 1 TableStats { DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1523 LastUpdateTime: 1523 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0 } TabletMetrics { Memory: 82328 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1459 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T10:03:32.363054Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [5:1537:2431], Recipient [4:529:2441]: NKikimrTxDataShard.TEvPeriodicTableStats DatashardId: 72075186224037890 TableLocalId: 3 Generation: 1 Round: 1 TableStats { DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1523 LastUpdateTime: 1523 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0 } TabletMetrics { Memory: 82328 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1459 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T10:03:32.363071Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-11-14T10:03:32.363085Z node 4 :FLAT_TX_SCHEMESHARD INFO: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] state 'Ready' dataSize 75 rowCount 1 cpuUsage 0
2025-11-14T10:03:32.363105Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] raw table stats:
DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1523 LastUpdateTime: 1523 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0
2025-11-14T10:03:32.363113Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.100000s, queue# 1
2025-11-14T10:03:32.378190Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715661. Ctx: { TraceId: 01ka0x3xmb8n0b5v0eqnf5k113, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=NDk0NjdmYy0xZTU4MjJmMi0zMjA3Njg0Yy01NWMxMjkwNQ==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-11-14T10:03:32.378593Z node 5 :TX_DATASHARD ERROR: Cannot perform writes: database is out of disk space
2025-11-14T10:03:32.378622Z node 5 :TX_DATASHARD ERROR: Prepare transaction failed. txid 281474976715661 at tablet 72075186224037890 errors: DISK_SPACE_EXHAUSTED (Cannot perform writes: database is out of disk space) |
2025-11-14T10:03:32.378650Z node 5 :TX_DATASHARD ERROR: Errors while proposing transaction txid 281474976715661 at tablet 72075186224037890 status: ERROR errors: DISK_SPACE_EXHAUSTED (Cannot perform writes: database is out of disk space) |
2025-11-14T10:03:32.378796Z node 4 :KQP_EXECUTER ERROR: ActorId: [4:1827:3104] TxId: 281474976715661. Ctx: { TraceId: 01ka0x3xmb8n0b5v0eqnf5k113, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=NDk0NjdmYy0xZTU4MjJmMi0zMjA3Njg0Yy01NWMxMjkwNQ==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. ERROR: [DISK_SPACE_EXHAUSTED] Cannot perform writes: database is out of disk space; 
2025-11-14T10:03:32.380527Z node 4 :KQP_SESSION WARN: SessionId: ydb://session/3?node_id=4&id=NDk0NjdmYy0xZTU4MjJmMi0zMjA3Njg0Yy01NWMxMjkwNQ==, ActorId: [4:1817:3104], ActorState: ExecuteState, TraceId: 01ka0x3xmb8n0b5v0eqnf5k113, Create QueryResponse for error on request, msg: 
2025-11-14T10:03:32.380808Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715662. Ctx: { TraceId: 01ka0x3xmb8n0b5v0eqnf5k113, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=NDk0NjdmYy0xZTU4MjJmMi0zMjA3Njg0Yy01NWMxMjkwNQ==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-11-14T10:03:32.482535Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T10:03:32.482563Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T10:03:32.482572Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 1
2025-11-14T10:03:32.482593Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 1
2025-11-14T10:03:32.482600Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.000000s, queue# 1
2025-11-14T10:03:32.482642Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: PersistSingleStats for pathId 3 shard idx 72057594046644480:3 data size 75 row count 1
2025-11-14T10:03:32.482664Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxStoreTableStats.PersistSingleStats: main stats from datashardId(TabletID)=72075186224037890 maps to shardIdx: 72057594046644480:3 followerId=0, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], pathId map=table, is column=0, is olap=0
2025-11-14T10:03:32.482677Z node 4 :FLAT_TX_SCHEMESHARD INFO: Add stats from shard with datashardId(TabletID)=72075186224037890 followerId=0, pathId 3: RowCount 1, DataSize 75
2025-11-14T10:03:32.482682Z node 4 :FLAT_TX_SCHEMESHARD TRACE: BuildStatsForCollector: datashardId 72075186224037890, followerId 0
2025-11-14T10:03:32.482703Z node 4 :FLAT_TX_SCHEMESHARD TRACE: [BackgroundCompaction] [Update] Skipped shard# 72057594046644480:3 with partCount# 1, rowCount# 1, searchHeight# 1, lastFullCompaction# 1970-01-01T00:00:01.000000Z at schemeshard 72057594046644480
2025-11-14T10:03:32.482825Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T10:03:32.482832Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 0, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T10:03:32.485042Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T10:03:32.485077Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T10:03:32.485086Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:749:2597], at schemeshard: 72057594046644480, txId: 0, path id: 2
2025-11-14T10:03:32.485350Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:749:2597], Recipient [4:529:2441]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 8 }
2025-11-14T10:03:32.485360Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T10:03:32.485383Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 8 PathOwnerId: 72057594046644480, cookie: 0
2025-11-14T10:03:32.496121Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T10:03:32.496146Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T10:03:32.496152Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-11-14T10:03:32.850817Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:32.850848Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:32.850881Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:32.850887Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:33.559484Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:33.559512Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:33.559557Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:33.559563Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:34.300766Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:34.300796Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:34.300821Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:34.300826Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:35.070413Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:35.070451Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:35.070481Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:35.070487Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:35.847576Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:35.847599Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T10:03:35.847628Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:529:2441], Recipient [4:529:2441]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T10:03:35.847633Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
Captured TEvDataShard::TEvPeriodicTableStats DatashardId: 72075186224037890 TableLocalId: 3 Generation: 1 Round: 2 TableStats { DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1523 LastUpdateTime: 1523 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 1 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0 } TabletMetrics { Memory: 82328 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1459 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T10:03:36.166366Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [5:1537:2431], Recipient [4:529:2441]: NKikimrTxDataShard.TEvPeriodicTableStats DatashardId: 72075186224037890 TableLocalId: 3 Generation: 1 Round: 2 TableStats { DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1523 LastUpdateTime: 1523 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 1 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0 } TabletMetrics { Memory: 82328 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1459 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T10:03:36.166385Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-11-14T10:03:36.166399Z node 4 :FLAT_TX_SCHEMESHARD INFO: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] state 'Ready' dataSize 75 rowCount 1 cpuUsage 0
2025-11-14T10:03:36.166416Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] raw table stats:
DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1523 LastUpdateTime: 1523 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 1 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0
2025-11-14T10:03:36.166424Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.100000s, queue# 1
2025-11-14T10:03:36.177592Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715663. Ctx: { TraceId: 01ka0x41b7b5emhfsrarast3mk, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=YzNkNzA3YTctNjNhYmRkNDctNDliODJjZmItYzZhY2NkOTE=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
