2025-11-14T08:29:58.794962Z 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/n9gb/0034e0/r3tmp/tmpUA77Rd/pdisk_1.dat
2025-11-14T08:29:59.300580Z node 4 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 1:0, at schemeshard:  72057594046644480
2025-11-14T08:29:59.367815Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-14T08:29:59.367955Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-14T08:29:59.383867Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-11-14T08:29:59.706722Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:966:2780], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:29:59.706829Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:29:59.706875Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:29:59.707038Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [4:963:2778], Recipient [4:543:2450]: {TEvModifySchemeTransaction txid# 281474976715657 TabletId# 72057594046644480}
2025-11-14T08:29:59.707077Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-11-14T08:29:59.817844Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Execute, message: Transaction { WorkingDir: "/Root" OperationType: ESchemeOpCreateSubDomain SubDomain { Name: "tenant" } } TxId: 281474976715657 TabletId: 72057594046644480 PeerName: "" , at schemeshard: 72057594046644480
2025-11-14T08:29:59.818140Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TCreateSubDomain Propose, path: /Root/tenant, opId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T08:29:59.818254Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: AttachChild: child attached as only one child to the parent, parent id: [OwnerId: 72057594046644480, LocalPathId: 1], parent name: Root, child name: tenant, child id: [OwnerId: 72057594046644480, LocalPathId: 2], at schemeshard: 72057594046644480
2025-11-14T08:29:59.818419Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 0
2025-11-14T08:29:59.818620Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason  for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 1
2025-11-14T08:29:59.818781Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976715657:1, propose status:StatusAccepted, reason: , at schemeshard: 72057594046644480
2025-11-14T08:29:59.818854Z node 4 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateSubDomain, opId: 281474976715657:0, at schemeshard:  72057594046644480
2025-11-14T08:29:59.818969Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:29:59.819069Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 1
2025-11-14T08:29:59.819137Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T08:29:59.824168Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976715657, response: Status: StatusAccepted TxId: 281474976715657 SchemeshardId: 72057594046644480 PathId: 2, at schemeshard: 72057594046644480
2025-11-14T08:29:59.824388Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976715657, database: /Root, subject: , status: StatusAccepted, operation: CREATE DATABASE, path: /Root/tenant
2025-11-14T08:29:59.824484Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:29:59.824555Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T08:29:59.824906Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:29:59.824957Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:29:59.825172Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T08:29:59.825230Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 1]
2025-11-14T08:29:59.825420Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T08:29:59.825547Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T08:29:59.825603Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 1
2025-11-14T08:29:59.825657Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 2
2025-11-14T08:29:59.826177Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T08:29:59.826247Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715657:0 ProgressState, operation type: TxCreateSubDomain, at tablet# 72057594046644480
2025-11-14T08:29:59.826297Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715657:0 ProgressState no shards to create, do next state
2025-11-14T08:29:59.826347Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715657:0 2 -> 3
2025-11-14T08:29:59.826468Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:29:59.826934Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:966:2780], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:29:59.826979Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:29:59.827133Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T08:29:59.829159Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 1] Version: 4 }
2025-11-14T08:29:59.829216Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:29:59.829308Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 1 Version: 4 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T08:29:59.829443Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 1 Version: 4 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T08:29:59.829498Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T08:29:59.829568Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 1], version: 4
2025-11-14T08:29:59.829626Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 2
2025-11-14T08:29:59.829763Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:29:59.830671Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 2 }
2025-11-14T08:29:59.830714Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:29:59.830771Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 2 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T08:29:59.830839Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 2 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T08:29:59.830866Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T08:29:59.830913Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 2
2025-11-14T08:29:59.830946Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 3
2025-11-14T08:29:59.831128Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715657, ready parts: 0/1, is published: true
2025-11-14T08:29:59.831192Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:29:59.834298Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:29:59.834360Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T08:29:59.834586Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:29:59.834626Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:29:59.834683Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T08:29:59.834759Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715657:0 ProgressState, at schemeshard: 72057594046644480
2025-11-14T08:29:59.834823Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715657:0 3 -> 128
2025-11-14T08:29:59.834927Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:29:59.835603Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T08:29:59.835658Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:29:59.837327Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T08:29:59.837365Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:29:59.838390Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:29:59.838429Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T08:29:59.838562Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:29:59.838600Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:29:59.838657Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T08:29:59.838699Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose ProgressState, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T08:29:59.838771Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose ProgressState leave, operationId 281474976715657:0, at tablet# 72057594046644480
2025-11-14T08:29:59.838813Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:29:59.838868Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976715657 ready parts: 1/1
2025-11-14T08:29:59.843009Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoPropose send propose to coordinator: 72057594046316545 message:Transaction { AffectedSet { TabletId: 72057594046644480 Flags: 2 } ExecLevel: 0 TxId: 281474976715657 MinStep: 0 MaxStep: 18446744073709551615 IgnoreLowDiskSpace: true } CoordinatorID: 72057594046316545
2025-11-14T08:29:59.844964Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:29:59.845023Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715657:4294967295 from tablet: 72057594046644480 to tablet: 72057594046316545 cookie: 0:281474976715657 msg type: 269090816
2025-11-14T08:29:59.845166Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715657, partId: 4294967295, tablet: 72057594046316545
2025-11-14T08:29:59.845463Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:536:2446], Recipient [4:543:2450]: NKikimrTx.TEvProposeTransactionStatus Status: 16 StepId: 1000 TxId: 281474976715657
2025-11-14T08:29:59.845980Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:986:2800], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:29:59.846039Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:29:59.846083Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:29:59.846227Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124996, Sender [4:906:2727], Recipient [4:543:2450]: NKikimrScheme.TEvNotifyTxCompletion TxId: 281474976715657
2025-11-14T08:29:59.846263Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvNotifyTxCompletion
2025-11-14T08:29:59.846355Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NotifyTxCompletion operation in-flight, txId: 281474976715657, at schemeshard: 72057594046644480
2025-11-14T08:29:59.846405Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715657, ready parts: 0/1, is published: true
2025-11-14T08:29:59.846468Z node 4 :FLAT_TX_SCHEMESHARD INFO: NotifyTxCompletion transaction is registered, txId: 281474976715657, at schemeshard: 72057594046644480
2025-11-14T08:30:00.189216Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:536:2446], Recipient [4:543:2450]: NKikimrTx.TEvProposeTransactionStatus Status: 17 StepId: 1000 TxId: 281474976715657
2025-11-14T08:30:00.189711Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [4:755:2601], Recipient [4:543:2450]: {TEvPlanStep step# 1000 MediatorId# 72057594046382081 TabletID 72057594046644480}
2025-11-14T08:30:00.189758Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-11-14T08:30:00.189854Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1000, transactions count in step: 1, at schemeshard: 72057594046644480
2025-11-14T08:30:00.189997Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPlanStep Execute, message: Transactions { TxId: 281474976715657 AckTo { RawX1: 0 RawX2: 0 } } Step: 1000 MediatorID: 72057594046382081 TabletID: 72057594046644480, at schemeshard: 72057594046644480
2025-11-14T08:30:00.190068Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715657:0, at tablet# 72057594046644480
2025-11-14T08:30:00.190321Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715657:0 128 -> 240
2025-11-14T08:30:00.190464Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715657:0, at tablet# 72057594046644480
2025-11-14T08:30:00.190660Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:00.190751Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 1
2025-11-14T08:30:00.190830Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T08:30:00.190873Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715657:4294967295 from tablet: 72057594046644480 to tablet: 0 cookie: 0:281474976715657
2025-11-14T08:30:00.190924Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DoUpdateTenant no IsExternalSubDomainRoot, pathId: : [OwnerId: 72057594046644480, LocalPathId: 2], at schemeshard: 72057594046644480
2025-11-14T08:30:00.193094Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:00.193156Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1000
2025-11-14T08:30:00.193243Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715657:0
2025-11-14T08:30:00.193623Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:30:00.193674Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:30:00.194067Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T08:30:00.194138Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 1]
2025-11-14T08:30:00.194373Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715657, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T08:30:00.194478Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T08:30:00.194528Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 1
2025-11-14T08:30:00.194584Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715657, path id: 2
2025-11-14T08:30:00.194791Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715657:0, at schemeshard: 72057594046644480
2025-11-14T08:30:00.194869Z node 4 :FLAT_TX_SCHEMESHARD INFO: [72057594046644480] TDone opId# 281474976715657:0 ProgressState
2025-11-14T08:30:00.195013Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:00.195083Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715657:0 progress is 1/1
2025-11-14T08:30:00.195125Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715657 ready parts: 1/1
2025-11-14T08:30:00.195172Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715657:0 progress is 1/1
2025-11-14T08:30:00.195215Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715657 ready parts: 1/1
2025-11-14T08:30:00.195267Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715657, ready parts: 1/1, is published: false
2025-11-14T08:30:00.195317Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715657 ready parts: 1/1
2025-11-14T08:30:00.195366Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976715657:0
2025-11-14T08:30:00.195414Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976715657:0
2025-11-14T08:30:00.195506Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 3
2025-11-14T08:30:00.195552Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication still in progress, tx: 281474976715657, publications: 2, subscribers: 1
2025-11-14T08:30:00.195779Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Publication details:  tx: 281474976715657, [OwnerId: 72057594046644480, LocalPathId: 1], 5
2025-11-14T08:30:00.195818Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Publication details:  tx: 281474976715657, [OwnerId: 72057594046644480, LocalPathId: 2], 3
2025-11-14T08:30:00.198389Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 1] Version: 5 }
2025-11-14T08:30:00.198455Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:30:00.198572Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 1 Version: 5 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T08:30:00.198688Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 1 Version: 5 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T08:30:00.198767Z node 4 :FLAT_TX_SCHEMESHARD INFO: Publication in-flight, count: 2, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T08:30:00.198852Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 1], version: 5
2025-11-14T08:30:00.198919Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 1] was 2
2025-11-14T08:30:00.199056Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:00.200301Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 3 }
2025-11-14T08:30:00.200352Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:30:00.200417Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 3 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T08:30:00.200504Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 3 PathOwnerId: 72057594046644480, cookie: 281474976715657
2025-11-14T08:30:00.200533Z node 4 :FLAT_TX_SCHEMESHARD INFO: Publication in-flight, count: 1, at schemeshard: 72057594046644480, txId: 281474976715657
2025-11-14T08:30:00.200581Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715657, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 3
2025-11-14T08:30:00.200622Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T08:30:00.200694Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication complete, notify & remove, at schemeshard: 72057594046644480, txId: 281474976715657, subscribers: 1
2025-11-14T08:30:00.200765Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Notify send TEvNotifyTxCompletionResult, at schemeshard: 72057594046644480, to actorId: [4:906:2727]
2025-11-14T08:30:00.200830Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:00.203477Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:00.205335Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T08:30:00.205568Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:00.205736Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715657
2025-11-14T08:30:00.205767Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:00.205876Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [4:906:2727] msg type: 271124998 msg: NKikimrScheme.TEvNotifyTxCompletionResult TxId: 281474976715657 at schemeshard: 72057594046644480
2025-11-14T08:30:00.208906Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1018:2825], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:00.208980Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:00.209027Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:30:00.209193Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [4:1008:2822], Recipient [4:543:2450]: {TEvModifySchemeTransaction txid# 281474976715658 TabletId# 72057594046644480}
2025-11-14T08:30:00.209231Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-11-14T08:30:00.212766Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Execute, message: Transaction { WorkingDir: "/Root" OperationType: ESchemeOpAlterSubDomain SubDomain { PlanResolution: 10 Coordinators: 1 Mediators: 1 Name: "tenant" TimeCastBucketsPerMediator: 2 StoragePools { Name: "/Root:ssd" Kind: "ssd" } StoragePools { Name: "/Root:hdd" Kind: "hdd" } DatabaseQuotas { storage_quotas { unit_kind: "hdd" data_size_hard_quota: 1 } } } } TxId: 281474976715658 TabletId: 72057594046644480 PeerName: "" , at schemeshard: 72057594046644480
2025-11-14T08:30:00.213040Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TAlterSubDomain Propose, path: /Root/tenant, opId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:30:00.213274Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 1
2025-11-14T08:30:00.213341Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 2
2025-11-14T08:30:00.213441Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 3
2025-11-14T08:30:00.213888Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976715658:1, propose status:StatusAccepted, reason: , at schemeshard: 72057594046644480
2025-11-14T08:30:00.213966Z node 4 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 281474976715658:0, at schemeshard:  72057594046644480
2025-11-14T08:30:00.214086Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:00.216752Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976715658, response: Status: StatusAccepted TxId: 281474976715658 SchemeshardId: 72057594046644480 PathId: 2, at schemeshard: 72057594046644480
2025-11-14T08:30:00.216939Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976715658, database: /Root, subject: , status: StatusAccepted, operation: ALTER DATABASE, path: /Root/tenant
2025-11-14T08:30:00.217004Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:00.217044Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T08:30:00.217327Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:30:00.217385Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:30:00.217467Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:30:00.217529Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715658:0 ProgressState, operation type: TxAlterSubDomain, at tablet# 72057594046644480
2025-11-14T08:30:00.217810Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715658:0 CreateRequest Event to Hive: 72057594037968897 msg:  Owner: 72057594046644480
OwnerIdx: 1
TabletType: Coordinator
ObjectDomain {
  SchemeShard: 72057594046644480
  PathId: 2
}
ObjectId: 2
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
AllowedDomains {
  SchemeShard: 72057594046644480
  PathId: 2
}
2025-11-14T08:30:00.217930Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715658:0 CreateRequest Event to Hive: 72057594037968897 msg:  Owner: 72057594046644480
OwnerIdx: 2
TabletType: Mediator
ObjectDomain {
  SchemeShard: 72057594046644480
  PathId: 2
}
ObjectId: 2
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
BindedChannels {
  StoragePoolName: "/Root:hdd"
}
AllowedDomains {
  SchemeShard: 72057594046644480
  PathId: 2
}
2025-11-14T08:30:00.217982Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:00.218419Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1018:2825], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:30:00.218464Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:30:00.218501Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T08:30:00.220317Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:00.220400Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:1 msg type: 268697601
2025-11-14T08:30:00.220563Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:2 msg type: 268697601
2025-11-14T08:30:00.220640Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 0, tablet: 72057594037968897
2025-11-14T08:30:00.220698Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:1, partId: 0
2025-11-14T08:30:00.220742Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:2, partId: 0
2025-11-14T08:30:00.221186Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1025:2832], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72057594037968897 Status: OK ServerId: [4:1026:2833] Leader: 1 Dead: 0 Generation: 2 VersionInfo:  }
2025-11-14T08:30:00.221235Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T08:30:00.221277Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72057594037968897, status: OK, at schemeshard: 72057594046644480
2025-11-14T08:30:03.086846Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1302:2847], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:03.086920Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:03.086958Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:30:03.090668Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122945, Sender [5:1264:2343], Recipient [4:1302:2847]
2025-11-14T08:30:03.090741Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvDescribeScheme
2025-11-14T08:30:03.105211Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1327:2853], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:03.105267Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:03.105293Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:30:03.105603Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [4:1298:2844], Recipient [4:543:2450]: {TEvModifySchemeTransaction txid# 281474976715659 TabletId# 72057594046644480}
2025-11-14T08:30:03.105641Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-11-14T08:30:03.108289Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Execute, message: Transaction { WorkingDir: "/Root/tenant" OperationType: ESchemeOpCreateTable CreateTable { Name: "table" Columns { Name: "Key" Type: "Uint32" NotNull: false } Columns { Name: "Value" Type: "Utf8" FamilyName: "hdd" NotNull: false } KeyColumnNames: "Key" PartitionConfig { ColumnFamilies { ColumnCodec: ColumnCodecPlain StorageConfig { SysLog { PreferredPoolKind: "ssd" } Log { PreferredPoolKind: "ssd" } Data { PreferredPoolKind: "ssd" AllowOtherKinds: false } } } ColumnFamilies { Name: "hdd" ColumnCodec: ColumnCodecLZ4 StorageConfig { Data { PreferredPoolKind: "hdd" AllowOtherKinds: false } } } } Temporary: false } } TxId: 281474976715659 TabletId: 72057594046644480 PeerName: "" , at schemeshard: 72057594046644480
2025-11-14T08:30:03.108861Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TCreateTable Propose, path: /Root/tenant/table, opId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.109049Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable Propose, path: /Root/tenant/table, opId: 281474976715659:0, schema: Name: "table" Columns { Name: "Key" Type: "Uint32" NotNull: false } Columns { Name: "Value" Type: "Utf8" FamilyName: "hdd" NotNull: false } KeyColumnNames: "Key" PartitionConfig { ColumnFamilies { ColumnCodec: ColumnCodecPlain StorageConfig { SysLog { PreferredPoolKind: "ssd" } Log { PreferredPoolKind: "ssd" } Data { PreferredPoolKind: "ssd" AllowOtherKinds: false } } } ColumnFamilies { Name: "hdd" ColumnCodec: ColumnCodecLZ4 StorageConfig { Data { PreferredPoolKind: "hdd" AllowOtherKinds: false } } } } Temporary: false, at schemeshard: 72057594046644480
2025-11-14T08:30:03.109746Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: AttachChild: child attached as only one child to the parent, parent id: [OwnerId: 72057594046644480, LocalPathId: 2], parent name: tenant, child name: table, child id: [OwnerId: 72057594046644480, LocalPathId: 3], at schemeshard: 72057594046644480
2025-11-14T08:30:03.109817Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 0
2025-11-14T08:30:03.109877Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 1
2025-11-14T08:30:03.110020Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new path created for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 2
2025-11-14T08:30:03.110068Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 1 -> 2
2025-11-14T08:30:03.110851Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TCreateTable Propose creating new table opId# 281474976715659:0 path# /Root/tenant/table pathId# [OwnerId: 72057594046644480, LocalPathId: 3] schemeshard# 72057594046644480 tx# WorkingDir: "/Root/tenant"
OperationType: ESchemeOpCreateTable
CreateTable {
  Name: "table"
  Columns {
    Name: "Key"
    Type: "Uint32"
    NotNull: false
  }
  Columns {
    Name: "Value"
    Type: "Utf8"
    FamilyName: "hdd"
    NotNull: false
  }
  KeyColumnNames: "Key"
  PartitionConfig {
    ColumnFamilies {
      ColumnCodec: ColumnCodecPlain
      StorageConfig {
        SysLog {
          PreferredPoolKind: "ssd"
        }
        Log {
          PreferredPoolKind: "ssd"
        }
        Data {
          PreferredPoolKind: "ssd"
          AllowOtherKinds: false
        }
      }
    }
    ColumnFamilies {
      Name: "hdd"
      ColumnCodec: ColumnCodecLZ4
      StorageConfig {
        Data {
          PreferredPoolKind: "hdd"
          AllowOtherKinds: false
        }
      }
    }
  }
  Temporary: false
}
FailOnExist: false
2025-11-14T08:30:03.111080Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976715659:1, propose status:StatusAccepted, reason: , at schemeshard: 72057594046644480
2025-11-14T08:30:03.111133Z node 4 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976715659:0, at schemeshard:  72057594046644480
2025-11-14T08:30:03.111280Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.111349Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T08:30:03.111402Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 3
2025-11-14T08:30:03.121249Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976715659, response: Status: StatusAccepted TxId: 281474976715659 SchemeshardId: 72057594046644480 PathId: 3, at schemeshard: 72057594046644480
2025-11-14T08:30:03.121501Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976715659, database: /Root/tenant, subject: , status: StatusAccepted, operation: CREATE TABLE, path: /Root/tenant/table
2025-11-14T08:30:03.121599Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.121650Z node 4 :FLAT_TX_SCHEMESHARD INFO: Delay activating, operation part: 281474976715659:0, there is await operations num 1
2025-11-14T08:30:03.121875Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T08:30:03.121925Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T08:30:03.122102Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 3]
2025-11-14T08:30:03.122190Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T08:30:03.122243Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 2
2025-11-14T08:30:03.122291Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 3
2025-11-14T08:30:03.124045Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1327:2853], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:30:03.124096Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:30:03.124135Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T08:30:03.124923Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 4 }
2025-11-14T08:30:03.124971Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:30:03.125062Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 4 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T08:30:03.125157Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 4 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T08:30:03.125195Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T08:30:03.125241Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 4
2025-11-14T08:30:03.125303Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 6
2025-11-14T08:30:03.125397Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.126072Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1337:2858], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:03.126123Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:03.126148Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:30:03.126442Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 3] Version: 1 }
2025-11-14T08:30:03.126473Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:30:03.126526Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 3 Version: 1 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T08:30:03.126623Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 3 Version: 1 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T08:30:03.126671Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T08:30:03.126697Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], version: 1
2025-11-14T08:30:03.126723Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 4
2025-11-14T08:30:03.126788Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 0/1, is published: true
2025-11-14T08:30:03.126824Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.127291Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124996, Sender [4:1297:2843], Recipient [4:543:2450]: NKikimrScheme.TEvNotifyTxCompletion TxId: 281474976715659
2025-11-14T08:30:03.127331Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvNotifyTxCompletion
2025-11-14T08:30:03.127394Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NotifyTxCompletion operation in-flight, txId: 281474976715659, at schemeshard: 72057594046644480
2025-11-14T08:30:03.127455Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 0/1, is published: true
2025-11-14T08:30:03.127535Z node 4 :FLAT_TX_SCHEMESHARD INFO: NotifyTxCompletion transaction is registered, txId: 281474976715659, at schemeshard: 72057594046644480
2025-11-14T08:30:03.145837Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T08:30:03.145922Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.146878Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T08:30:03.146910Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.148569Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(5, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-14T08:30:03.148686Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(5, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-14T08:30:03.182834Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [4:546:2452], Recipient [4:543:2450]: {EvCreateTabletReply Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897}
2025-11-14T08:30:03.182912Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-11-14T08:30:03.183039Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72057594046644480 message: Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897
2025-11-14T08:30:03.183096Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:1, partId: 0
2025-11-14T08:30:03.183247Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897
2025-11-14T08:30:03.183304Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, at tabletId: 72057594046644480
2025-11-14T08:30:03.183391Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, message: Status: OK Owner: 72057594046644480 OwnerIdx: 1 TabletID: 72075186224037888 Origin: 72057594037968897
2025-11-14T08:30:03.183516Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.183565Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:1
2025-11-14T08:30:03.184005Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [4:546:2452], Recipient [4:543:2450]: {EvCreateTabletReply Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897}
2025-11-14T08:30:03.184061Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-11-14T08:30:03.184121Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72057594046644480 message: Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897
2025-11-14T08:30:03.184166Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976715658, shardIdx: 72057594046644480:2, partId: 0
2025-11-14T08:30:03.184241Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897
2025-11-14T08:30:03.184276Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, at tabletId: 72057594046644480
2025-11-14T08:30:03.184332Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715658:0 HandleReply TEvCreateTabletReply, message: Status: OK Owner: 72057594046644480 OwnerIdx: 2 TabletID: 72075186224037889 Origin: 72057594037968897
2025-11-14T08:30:03.184399Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715658:0 2 -> 3
2025-11-14T08:30:03.184495Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.184525Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:2
2025-11-14T08:30:03.184700Z node 4 :HIVE WARN: HIVE#72057594037968897 Handle TEvInterconnect::TEvNodeConnected, NodeId 5 Cookie 5
2025-11-14T08:30:03.187813Z node 4 :HIVE WARN: HIVE#72057594037968897 Node(5, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-11-14T08:30:03.189167Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.189235Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.190306Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.190338Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.190375Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T08:30:03.190519Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:30:03.190559Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:30:03.190648Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.190701Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715658:0 ProgressState, at schemeshard: 72057594046644480
2025-11-14T08:30:03.190783Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send configure request to coordinator/mediator: 72075186224037888 opId: 281474976715658:0 schemeshard: 72057594046644480
2025-11-14T08:30:03.190845Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send configure request to coordinator/mediator: 72075186224037889 opId: 281474976715658:0 schemeshard: 72057594046644480
2025-11-14T08:30:03.190882Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.192778Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.192843Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037888 cookie: 72057594046644480:1 msg type: 272564224
2025-11-14T08:30:03.193009Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037889 cookie: 72057594046644480:2 msg type: 272564224
2025-11-14T08:30:03.193123Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 0, tablet: 72075186224037888
2025-11-14T08:30:03.193176Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 0, tablet: 72075186224037889
2025-11-14T08:30:03.322800Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [4:546:2452], Recipient [4:543:2450]: {EvTabletCreationResult Status: OK TabletID: 72075186224037888}
2025-11-14T08:30:03.322897Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [4:546:2452], Recipient [4:543:2450]: {EvTabletCreationResult Status: OK TabletID: 72075186224037889}
2025-11-14T08:30:03.364036Z node 4 :TX_CONVEYOR ERROR: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-11-14T08:30:03.377633Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1356:2877], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72075186224037888 Status: OK ServerId: [5:1451:2401] Leader: 1 Dead: 0 Generation: 1 VersionInfo:  }
2025-11-14T08:30:03.377701Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T08:30:03.377745Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037888, status: OK, at schemeshard: 72057594046644480
2025-11-14T08:30:03.377867Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:03.377901Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:03.378771Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1357:2878], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72075186224037889 Status: OK ServerId: [5:1452:2402] Leader: 1 Dead: 0 Generation: 1 VersionInfo:  }
2025-11-14T08:30:03.378812Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T08:30:03.378850Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037889, status: OK, at schemeshard: 72057594046644480
2025-11-14T08:30:03.386708Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 272564225, Sender [5:1387:2370], Recipient [4:543:2450]
2025-11-14T08:30:03.386787Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSubDomain::TEvConfigureStatus
2025-11-14T08:30:03.386883Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715658, tablet: 72075186224037888, partId: 0
2025-11-14T08:30:03.387111Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: SUCCESS OnTabletId: 72075186224037888
2025-11-14T08:30:03.387194Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715658:0 HandleReply TEvConfigureStatus operationId:281474976715658:0 at schemeshard:72057594046644480
2025-11-14T08:30:03.387264Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TConfigureParts operationId# 281474976715658:0 Got OK TEvConfigureStatus from  tablet# 72075186224037888 shardIdx# 72057594046644480:1 at schemeshard# 72057594046644480
2025-11-14T08:30:03.387307Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.387353Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037888 cookie: 72057594046644480:1
2025-11-14T08:30:03.388005Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 272564225, Sender [5:1389:2371], Recipient [4:543:2450]
2025-11-14T08:30:03.388062Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSubDomain::TEvConfigureStatus
2025-11-14T08:30:03.388117Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715658, tablet: 72075186224037889, partId: 0
2025-11-14T08:30:03.388230Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480, message: Status: SUCCESS OnTabletId: 72075186224037889
2025-11-14T08:30:03.388263Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TConfigureParts operationId# 281474976715658:0 HandleReply TEvConfigureStatus operationId:281474976715658:0 at schemeshard:72057594046644480
2025-11-14T08:30:03.388294Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TConfigureParts operationId# 281474976715658:0 Got OK TEvConfigureStatus from  tablet# 72075186224037889 shardIdx# 72057594046644480:2 at schemeshard# 72057594046644480
2025-11-14T08:30:03.388332Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715658:0 3 -> 128
2025-11-14T08:30:03.388439Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.388474Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:0 from tablet: 72057594046644480 to tablet: 72075186224037889 cookie: 72057594046644480:2
2025-11-14T08:30:03.391442Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.391520Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.394445Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvSubDomain::TEvConfigureStatus> complete, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.394502Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.394534Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T08:30:03.394727Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:30:03.394763Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:30:03.394805Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.394856Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose ProgressState, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.394931Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose ProgressState leave, operationId 281474976715658:0, at tablet# 72057594046644480
2025-11-14T08:30:03.394975Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.395080Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976715658 ready parts: 1/1
2025-11-14T08:30:03.395249Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoPropose send propose to coordinator: 72057594046316545 message:Transaction { AffectedSet { TabletId: 72057594046644480 Flags: 2 } ExecLevel: 0 TxId: 281474976715658 MinStep: 0 MaxStep: 18446744073709551615 IgnoreLowDiskSpace: true } CoordinatorID: 72057594046316545
2025-11-14T08:30:03.403249Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.403317Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715658:4294967295 from tablet: 72057594046644480 to tablet: 72057594046316545 cookie: 0:281474976715658 msg type: 269090816
2025-11-14T08:30:03.403440Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715658, partId: 4294967295, tablet: 72057594046316545
2025-11-14T08:30:03.403762Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:536:2446], Recipient [4:543:2450]: NKikimrTx.TEvProposeTransactionStatus Status: 16 StepId: 1500 TxId: 281474976715658
2025-11-14T08:30:03.740019Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [4:536:2446], Recipient [4:543:2450]: NKikimrTx.TEvProposeTransactionStatus Status: 17 StepId: 1500 TxId: 281474976715658
2025-11-14T08:30:03.740549Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [4:755:2601], Recipient [4:543:2450]: {TEvPlanStep step# 1500 MediatorId# 72057594046382081 TabletID 72057594046644480}
2025-11-14T08:30:03.740591Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-11-14T08:30:03.740681Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1500, transactions count in step: 1, at schemeshard: 72057594046644480
2025-11-14T08:30:03.740813Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPlanStep Execute, message: Transactions { TxId: 281474976715658 AckTo { RawX1: 0 RawX2: 0 } } Step: 1500 MediatorID: 72057594046382081 TabletID: 72057594046644480, at schemeshard: 72057594046644480
2025-11-14T08:30:03.740950Z node 4 :FLAT_TX_SCHEMESHARD INFO: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715658:0, at tablet# 72057594046644480
2025-11-14T08:30:03.741278Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715658:0 128 -> 240
2025-11-14T08:30:03.741345Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NSubDomainState::TPropose HandleReply TEvOperationPlan, operationId 281474976715658:0, at tablet# 72057594046644480
2025-11-14T08:30:03.741502Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.741572Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T08:30:03.741639Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715658:4294967295 from tablet: 72057594046644480 to tablet: 0 cookie: 0:281474976715658
2025-11-14T08:30:03.741703Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DoUpdateTenant no IsExternalSubDomainRoot, pathId: : [OwnerId: 72057594046644480, LocalPathId: 2], at schemeshard: 72057594046644480
2025-11-14T08:30:03.743840Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.743897Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1500
2025-11-14T08:30:03.743957Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715658:0
2025-11-14T08:30:03.744302Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:30:03.744341Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:30:03.744690Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T08:30:03.744726Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715658, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T08:30:03.744965Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T08:30:03.745005Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715658, path id: 2
2025-11-14T08:30:03.745484Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715658:0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.745540Z node 4 :FLAT_TX_SCHEMESHARD INFO: [72057594046644480] TDone opId# 281474976715658:0 ProgressState
2025-11-14T08:30:03.745637Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.745672Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715658:0 progress is 1/1
2025-11-14T08:30:03.745704Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715658 ready parts: 1/1
2025-11-14T08:30:03.745741Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715658:0 progress is 1/1
2025-11-14T08:30:03.745771Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715658 ready parts: 1/1
2025-11-14T08:30:03.745815Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715658, ready parts: 1/1, is published: false
2025-11-14T08:30:03.745859Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715658 ready parts: 1/1
2025-11-14T08:30:03.745891Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Remove dependency, parent tx: 281474976715658, dependent tx: 281474976715659
2025-11-14T08:30:03.745956Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976715658:0
2025-11-14T08:30:03.745980Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976715658:0
2025-11-14T08:30:03.746136Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 6
2025-11-14T08:30:03.746209Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication still in progress, tx: 281474976715658, publications: 1, subscribers: 0
2025-11-14T08:30:03.746252Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Publication details:  tx: 281474976715658, [OwnerId: 72057594046644480, LocalPathId: 2], 5
2025-11-14T08:30:03.746740Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 5 }
2025-11-14T08:30:03.746765Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:30:03.746815Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 5 PathOwnerId: 72057594046644480, cookie: 281474976715658
2025-11-14T08:30:03.746880Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 5 PathOwnerId: 72057594046644480, cookie: 281474976715658
2025-11-14T08:30:03.746903Z node 4 :FLAT_TX_SCHEMESHARD INFO: Publication in-flight, count: 1, at schemeshard: 72057594046644480, txId: 281474976715658
2025-11-14T08:30:03.746941Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715658, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 5
2025-11-14T08:30:03.746970Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T08:30:03.747193Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Publication complete, notify & remove, at schemeshard: 72057594046644480, txId: 281474976715658, subscribers: 0
2025-11-14T08:30:03.747246Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.755407Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.755471Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T08:30:03.755764Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:30:03.755817Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:30:03.755895Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.755980Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715659:0 ProgressState, operation type: TxCreateTable, at tablet# 72057594046644480
2025-11-14T08:30:03.756328Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715659:0 CreateRequest Event to Hive: 72057594037968897 msg:  Owner: 72057594046644480
OwnerIdx: 3
TabletType: DataShard
ObjectDomain {
  SchemeShard: 72057594046644480
  PathId: 2
}
ObjectId: 3
BindedChannels {
  StoragePoolName: "/Root:ssd"
  StoragePoolKind: "ssd"
}
BindedChannels {
  StoragePoolName: "/Root:ssd"
  StoragePoolKind: "ssd"
}
BindedChannels {
  StoragePoolName: "/Root:hdd"
  StoragePoolKind: "hdd"
}
AllowedDomains {
  SchemeShard: 72057594046644480
  PathId: 2
}
2025-11-14T08:30:03.756418Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.756725Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715658
2025-11-14T08:30:03.756757Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.759843Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.759902Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:3 msg type: 268697601
2025-11-14T08:30:03.760065Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715659, partId: 0, tablet: 72057594037968897
2025-11-14T08:30:03.760126Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976715659, shardIdx: 72057594046644480:3, partId: 0
2025-11-14T08:30:03.775215Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [4:546:2452], Recipient [4:543:2450]: {EvCreateTabletReply Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897}
2025-11-14T08:30:03.775273Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-11-14T08:30:03.775353Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72057594046644480 message: Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897
2025-11-14T08:30:03.775385Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976715659, shardIdx: 72057594046644480:3, partId: 0
2025-11-14T08:30:03.775470Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480, message: Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897
2025-11-14T08:30:03.775559Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976715659:0 HandleReply TEvCreateTabletReply, at tabletId: 72057594046644480
2025-11-14T08:30:03.775621Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976715659:0 HandleReply TEvCreateTabletReply, message: Status: OK Owner: 72057594046644480 OwnerIdx: 3 TabletID: 72075186224037890 Origin: 72057594037968897
2025-11-14T08:30:03.775704Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 2 -> 3
2025-11-14T08:30:03.775779Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.775828Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72057594037968897 cookie: 72057594046644480:3
2025-11-14T08:30:03.780386Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.780432Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.780492Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T08:30:03.780666Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:30:03.780712Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:30:03.780769Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.780814Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TConfigureParts operationId# 281474976715659:0 ProgressState at tabletId# 72057594046644480
2025-11-14T08:30:03.780924Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable TConfigureParts operationId# 281474976715659:0 ProgressState Propose modify scheme on datashard datashardId: 72075186224037890 seqNo: 2:1
2025-11-14T08:30:03.781430Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable TConfigureParts operationId# 281474976715659:0 ProgressState Propose modify scheme on datashard datashardId: 72075186224037890 message: TxKind: TX_KIND_SCHEME SourceDeprecated { RawX1: 543 RawX2: 17179871634 } TxBody: "\n\211\005\n\005table\020\003\032\r\n\003Key\030\002 \001(\000@\000\032\020\n\005Value\030\200$ \002(\001@\000(\001:\243\004\022\253\003\010\200\200\200\002\020\254\002\030\364\003 \200\200\200\010(\0000\200\200\200 8\200\200\200\010@\2008H\000RX\010\000\020\000\030\010 \010(\200\200\200@0\377\377\377\377\0178\001B$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionJ\017compaction_gen1P\nX\200\200\001`nh\000p\000Rb\010\001\020\200\200\200\024\030\005 \020(\200\200\200\200\0020\377\377\377\377\0178\000B$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionJ\017compaction_gen2P\nX\200\200\001`nh\200\200\200\004p\200\200\200\004Rc\010\002\020\200\200\200\310\001\030\005 \020(\200\200\200\200@0\377\377\377\377\0178\000B$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionJ\017compaction_gen3P\nX\200\200\001`nh\200\200\200(p\200\200\200(X\001`\005j$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionr\017compaction_gen0z\017compaction_gen0\202\001\004scan\210\001\200\200\200\010\220\001\364\003\230\0012\270\001\2008\300\001\006R\002\020\001b\035\010\0000\000J\027\n\005\n\003ssd\022\005\n\003ssd\032\007\n\003ssd\020\000b\026\010\001\020\001*\003hdd0\001J\t\032\007\n\003hdd\020\000\212\001&\010\000\022\004\010\001\020\000\022\004\010\002\020\001\022\004\010\003\020\001\032\004\010\001\020\000\032\004\010\002\020\001\032\004\010\003\020\001\212\001\016\010\001\022\004\010\003\020\002\032\004\010\003\020\002J\022/Root/tenant/table\242\001\006\001\000\000\000\000\200\252\001\000\260\001\001\270\001\000\210\002\001\222\002\013\t\000\001\205\000\000\000\000\001\020\003:\004\010\002\020\001" TxId: 281474976715659 ExecLevel: 0 Flags: 0 SchemeShardId: 72057594046644480 ProcessingParams { Version: 2 PlanResolution: 10 Coordinators: 72075186224037888 TimeCastBucketsPerMediator: 2 Mediators: 72075186224037889 } SubDomainPathId: 2
2025-11-14T08:30:03.781577Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.783974Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.784024Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72075186224037890 cookie: 72057594046644480:3 msg type: 269549568
2025-11-14T08:30:03.784167Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715659, partId: 0, tablet: 72075186224037890
2025-11-14T08:30:03.898818Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [4:546:2452], Recipient [4:543:2450]: {EvTabletCreationResult Status: OK TabletID: 72075186224037890}
2025-11-14T08:30:03.932015Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [4:1521:2943], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvClientConnected { TabletId: 72075186224037890 Status: OK ServerId: [5:1571:2449] Leader: 1 Dead: 0 Generation: 1 VersionInfo:  }
2025-11-14T08:30:03.932100Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-11-14T08:30:03.932166Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037890, status: OK, at schemeshard: 72057594046644480
2025-11-14T08:30:03.959953Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269550080, Sender [5:1538:2430], Recipient [4:543:2450]
2025-11-14T08:30:03.960013Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvProposeTransactionResult
2025-11-14T08:30:03.962929Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvProposeTransactionResult, at schemeshard: 72057594046644480, message: TxKind: TX_KIND_SCHEME Origin: 72075186224037890 Status: PREPARED TxId: 281474976715659 MinStep: 1 MaxStep: 18446744073709551615 PrepareArriveTime: 1508512 ExecLatency: 0 ProposeLatency: 1 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 380 } }
2025-11-14T08:30:03.963003Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715659, tablet: 72075186224037890, partId: 0
2025-11-14T08:30:03.963222Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480, message: TxKind: TX_KIND_SCHEME Origin: 72075186224037890 Status: PREPARED TxId: 281474976715659 MinStep: 1 MaxStep: 18446744073709551615 PrepareArriveTime: 1508512 ExecLatency: 0 ProposeLatency: 1 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 380 } }
2025-11-14T08:30:03.963294Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TConfigureParts operationId# 281474976715659:0 HandleReply TEvProposeTransactionResult at tabletId# 72057594046644480
2025-11-14T08:30:03.963404Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable TConfigureParts operationId# 281474976715659:0 HandleReply TEvProposeTransactionResult message: TxKind: TX_KIND_SCHEME Origin: 72075186224037890 Status: PREPARED TxId: 281474976715659 MinStep: 1 MaxStep: 18446744073709551615 PrepareArriveTime: 1508512 ExecLatency: 0 ProposeLatency: 1 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 380 } }
2025-11-14T08:30:03.963454Z node 4 :FLAT_TX_SCHEMESHARD INFO: TEvProposeTransactionResult at tablet: 72057594046644480
2025-11-14T08:30:03.963562Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: CollectProposeTransactionResults accept TEvProposeTransactionResult, shard: 72075186224037890, shardIdx: 72057594046644480:3, operationId: 281474976715659:0, left await: 0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.963607Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 3 -> 128
2025-11-14T08:30:03.963687Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.963738Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715659:0 from tablet: 72057594046644480 to tablet: 72075186224037890 cookie: 72057594046644480:3
2025-11-14T08:30:03.966343Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.966409Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.966456Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T08:30:03.966655Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:30:03.966690Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:30:03.966746Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.966819Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TPropose operationId# 281474976715659:0 HandleReply ProgressState at tablet: 72057594046644480
2025-11-14T08:30:03.966874Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.966920Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976715659 ready parts: 1/1
2025-11-14T08:30:03.967060Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoPropose send propose to coordinator: 72075186224037888 message:Transaction { AffectedSet { TabletId: 72057594046644480 Flags: 2 } AffectedSet { TabletId: 72075186224037890 Flags: 2 } ExecLevel: 0 TxId: 281474976715659 MinStep: 1 MaxStep: 18446744073709551615 IgnoreLowDiskSpace: true } CoordinatorID: 72075186224037888
2025-11-14T08:30:03.968848Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.968903Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976715659:4294967295 from tablet: 72057594046644480 to tablet: 72075186224037888 cookie: 0:281474976715659 msg type: 269090816
2025-11-14T08:30:03.969051Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976715659, partId: 4294967295, tablet: 72075186224037888
2025-11-14T08:30:03.969873Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [5:1387:2370], Recipient [4:543:2450]
2025-11-14T08:30:03.973065Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [5:1387:2370], Recipient [4:543:2450]
2025-11-14T08:30:03.973670Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1594:2957], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:03.973715Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:03.973736Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:30:03.974923Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [5:1464:2410], Recipient [4:1594:2957]
2025-11-14T08:30:03.974973Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-11-14T08:30:03.975081Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1560, transactions count in step: 1, at schemeshard: 72057594046644480
2025-11-14T08:30:03.975193Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPlanStep Execute, message: Transactions { TxId: 281474976715659 AckTo { RawX1: 0 RawX2: 0 } } Step: 1560 MediatorID: 72075186224037889 TabletID: 72057594046644480, at schemeshard: 72057594046644480
2025-11-14T08:30:03.975249Z node 4 :FLAT_TX_SCHEMESHARD INFO: TCreateTable TPropose operationId# 281474976715659:0 HandleReply TEvOperationPlan at tablet: 72057594046644480, stepId: 1560
2025-11-14T08:30:03.975387Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 128 -> 129
2025-11-14T08:30:03.975501Z node 4 :FLAT_TX_SCHEMESHARD TRACE: NTableState::TProposedWaitParts operationId# 281474976715659:0 Constructed
2025-11-14T08:30:03.975563Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.975621Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 4
2025-11-14T08:30:03.975670Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 3
2025-11-14T08:30:03.975704Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976715659:4294967295 from tablet: 72057594046644480 to tablet: 0 cookie: 0:281474976715659
2025-11-14T08:30:03.983642Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.983688Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1560
2025-11-14T08:30:03.983720Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T08:30:03.984021Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:30:03.984061Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:30:03.984143Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T08:30:03.984170Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T08:30:03.984310Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 281474976715659, path id: [OwnerId: 72057594046644480, LocalPathId: 3]
2025-11-14T08:30:03.984566Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T08:30:03.984608Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 2
2025-11-14T08:30:03.984653Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 281474976715659, path id: 3
2025-11-14T08:30:03.985348Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:30:03.985403Z node 4 :FLAT_TX_SCHEMESHARD INFO: NTableState::TProposedWaitParts operationId# 281474976715659:0 ProgressState at tablet: 72057594046644480
2025-11-14T08:30:03.985498Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.986839Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 6 }
2025-11-14T08:30:03.986879Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:30:03.986965Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 6 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T08:30:03.987379Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 6 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T08:30:03.987424Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T08:30:03.987458Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 2], version: 6
2025-11-14T08:30:03.987501Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 2] was 5
2025-11-14T08:30:03.987582Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.988738Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 3] Version: 3 }
2025-11-14T08:30:03.988777Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:30:03.988841Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 3 Version: 3 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T08:30:03.988903Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 3 Version: 3 PathOwnerId: 72057594046644480, cookie: 281474976715659
2025-11-14T08:30:03.988940Z node 4 :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72057594046644480, txId: 281474976715659
2025-11-14T08:30:03.988975Z node 4 :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72057594046644480, txId: 281474976715659, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], version: 3
2025-11-14T08:30:03.989007Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 4
2025-11-14T08:30:03.989060Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 0/1, is published: true
2025-11-14T08:30:03.989096Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:03.992230Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.998125Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T08:30:03.998172Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:03.998393Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72057594046644480, cookie: 281474976715659
2025-11-14T08:30:03.998418Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:04.000580Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269550080, Sender [5:1538:2430], Recipient [4:543:2450]
2025-11-14T08:30:04.000635Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvProposeTransactionResult
2025-11-14T08:30:04.000777Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvProposeTransactionResult, at schemeshard: 72057594046644480, message: TxKind: TX_KIND_SCHEME Origin: 72075186224037890 Status: COMPLETE TxId: 281474976715659 Step: 1560 OrderId: 281474976715659 ExecLatency: 0 ProposeLatency: 6 DomainCoordinators: 72075186224037888 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 1523 } }
2025-11-14T08:30:04.000814Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715659, tablet: 72075186224037890, partId: 0
2025-11-14T08:30:04.000925Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480, message: TxKind: TX_KIND_SCHEME Origin: 72075186224037890 Status: COMPLETE TxId: 281474976715659 Step: 1560 OrderId: 281474976715659 ExecLatency: 0 ProposeLatency: 6 DomainCoordinators: 72075186224037888 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 1523 } }
2025-11-14T08:30:04.001046Z node 4 :FLAT_TX_SCHEMESHARD INFO: HandleReply TEvDataShard::TEvProposeTransactionResult Ignore message: tablet# 72057594046644480, ev# TxKind: TX_KIND_SCHEME Origin: 72075186224037890 Status: COMPLETE TxId: 281474976715659 Step: 1560 OrderId: 281474976715659 ExecLatency: 0 ProposeLatency: 6 DomainCoordinators: 72075186224037888 TxStats { PerShardStats { ShardId: 72075186224037890 CpuTimeUsec: 1523 } }
2025-11-14T08:30:04.001099Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:04.001932Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1624:2972], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:04.001991Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:04.002016Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:30:04.003986Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269551620, Sender [5:1538:2430], Recipient [4:1624:2972]
2025-11-14T08:30:04.004035Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvSchemaChanged
2025-11-14T08:30:04.004183Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvSchemaChanged, tabletId: 72057594046644480, at schemeshard: 72057594046644480, message: Source { RawX1: 1538 RawX2: 21474838910 } Origin: 72075186224037890 State: 2 TxId: 281474976715659 Step: 0 Generation: 1
2025-11-14T08:30:04.004231Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976715659, tablet: 72075186224037890, partId: 0
2025-11-14T08:30:04.004434Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvSchemaChanged> execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480, message: Source { RawX1: 1538 RawX2: 21474838910 } Origin: 72075186224037890 State: 2 TxId: 281474976715659 Step: 0 Generation: 1
2025-11-14T08:30:04.004509Z node 4 :FLAT_TX_SCHEMESHARD INFO: NTableState::TProposedWaitParts operationId# 281474976715659:0 HandleReply TEvDataShard::TEvSchemaChanged at tablet: 72057594046644480
2025-11-14T08:30:04.004623Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: NTableState::TProposedWaitParts operationId# 281474976715659:0 HandleReply TEvDataShard::TEvSchemaChanged at tablet: 72057594046644480 message: Source { RawX1: 1538 RawX2: 21474838910 } Origin: 72075186224037890 State: 2 TxId: 281474976715659 Step: 0 Generation: 1
2025-11-14T08:30:04.004695Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: CollectSchemaChanged accept TEvDataShard::TEvSchemaChanged, operationId: 281474976715659:0, shardIdx: 72057594046644480:3, shard: 72075186224037890, left await: 0, txState.State: ProposedWaitParts, txState.ReadyForNotifications: 1, at schemeshard: 72057594046644480
2025-11-14T08:30:04.004736Z node 4 :FLAT_TX_SCHEMESHARD INFO: all shard schema changes has been received, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:30:04.004791Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: send schema changes ack message, operation: 281474976715659:0, datashard: 72075186224037890, at schemeshard: 72057594046644480
2025-11-14T08:30:04.004853Z node 4 :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976715659:0 129 -> 240
2025-11-14T08:30:04.005004Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:04.005674Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:30:04.005706Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:04.007560Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvSchemaChanged> complete, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:30:04.007608Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:04.007644Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976715659:0
2025-11-14T08:30:04.007788Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [5:1538:2430] msg type: 269552132 msg: NKikimrTxDataShard.TEvSchemaChangedResult TxId: 281474976715659 at schemeshard: 72057594046644480
2025-11-14T08:30:04.008018Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-11-14T08:30:04.008050Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-11-14T08:30:04.008109Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976715659:0, at schemeshard: 72057594046644480
2025-11-14T08:30:04.008154Z node 4 :FLAT_TX_SCHEMESHARD INFO: [72057594046644480] TDone opId# 281474976715659:0 ProgressState
2025-11-14T08:30:04.008267Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72057594046644480
2025-11-14T08:30:04.008316Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715659:0 progress is 1/1
2025-11-14T08:30:04.008355Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715659 ready parts: 1/1
2025-11-14T08:30:04.008419Z node 4 :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976715659:0 progress is 1/1
2025-11-14T08:30:04.008523Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715659 ready parts: 1/1
2025-11-14T08:30:04.008570Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976715659, ready parts: 1/1, is published: true
2025-11-14T08:30:04.008641Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoNotify send TEvNotifyTxCompletionResult to actorId: [4:1297:2843] message: TxId: 281474976715659
2025-11-14T08:30:04.008696Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976715659 ready parts: 1/1
2025-11-14T08:30:04.008744Z node 4 :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976715659:0
2025-11-14T08:30:04.008779Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976715659:0
2025-11-14T08:30:04.008910Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72057594046644480, LocalPathId: 3] was 3
2025-11-14T08:30:04.010952Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:04.011072Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [4:1297:2843] msg type: 271124998 msg: NKikimrScheme.TEvNotifyTxCompletionResult TxId: 281474976715659 at schemeshard: 72057594046644480
2025-11-14T08:30:04.011461Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1337:2858], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:30:04.011533Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:30:04.011556Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T08:30:04.108826Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715660. Ctx: { TraceId: 01ka0qrrqh16p885t18r0z1y6n, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=Mzc4YTU2YzUtNTJkNjk4ZmYtY2ExZWE3OWMtOGM1NjRmNGQ=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-11-14T08:30:04.137162Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [4:1624:2972], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:30:04.137231Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-11-14T08:30:04.137292Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72057594046644480
2025-11-14T08:30:04.139992Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1656:2996], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:04.140088Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:04.140148Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:30:04.140405Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122945, Sender [4:1653:2993], Recipient [4:543:2450]: NKikimrSchemeOp.TDescribePath Path: "/Root/tenant/table" Options { ShowPrivateTable: true }
2025-11-14T08:30:04.140441Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvDescribeScheme
2025-11-14T08:30:04.189768Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [4:1674:3003], Recipient [4:543:2450]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:04.189850Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-11-14T08:30:04.189903Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72057594046644480
2025-11-14T08:30:04.190758Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [5:1538:2430], Recipient [4:1674:3003]
2025-11-14T08:30:04.190820Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-11-14T08:30:04.190922Z node 4 :FLAT_TX_SCHEMESHARD INFO: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] state 'Ready' dataSize 75 rowCount 1 cpuUsage 0
2025-11-14T08:30:04.191142Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] raw table stats:
DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1523 LastUpdateTime: 1523 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0
2025-11-14T08:30:04.191201Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.100000s, queue# 1
2025-11-14T08:30:04.292796Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T08:30:04.292909Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T08:30:04.292954Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 1
2025-11-14T08:30:04.293033Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 1
2025-11-14T08:30:04.293076Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.000000s, queue# 1
2025-11-14T08:30:04.293213Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: PersistSingleStats for pathId 3 shard idx 72057594046644480:3 data size 75 row count 1
2025-11-14T08:30:04.293293Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxStoreTableStats.PersistSingleStats: main stats from datashardId(TabletID)=72075186224037890 maps to shardIdx: 72057594046644480:3 followerId=0, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], pathId map=table, is column=0, is olap=0
2025-11-14T08:30:04.293348Z node 4 :FLAT_TX_SCHEMESHARD INFO: Add stats from shard with datashardId(TabletID)=72075186224037890 followerId=0, pathId 3: RowCount 1, DataSize 75
2025-11-14T08:30:04.293394Z node 4 :FLAT_TX_SCHEMESHARD TRACE: BuildStatsForCollector: datashardId 72075186224037890, followerId 0
2025-11-14T08:30:04.293514Z node 4 :FLAT_TX_SCHEMESHARD TRACE: [BackgroundCompaction] [Update] Skipped shard# 72057594046644480:3 with partCount# 1, rowCount# 1, searchHeight# 1, lastFullCompaction# 1970-01-01T00:00:01.000000Z at schemeshard 72057594046644480
2025-11-14T08:30:04.294019Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T08:30:04.294073Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 0, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T08:30:04.299046Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:04.299151Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T08:30:04.299220Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 0, path id: 2
2025-11-14T08:30:04.300729Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 7 }
2025-11-14T08:30:04.300791Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:30:04.300902Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 7 PathOwnerId: 72057594046644480, cookie: 0
2025-11-14T08:30:04.313013Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T08:30:04.313089Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T08:30:04.313118Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-11-14T08:30:04.539769Z node 5 :TX_CONVEYOR ERROR: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-11-14T08:30:04.638973Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:04.639067Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:04.639216Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:04.639252Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:05.302243Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:05.302349Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:05.302463Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:05.302491Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:05.846672Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:05.846741Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:05.846861Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:05.846892Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:06.390519Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:06.390601Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:06.390738Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:06.390789Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:06.995842Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:06.995924Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:06.996036Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:06.996068Z 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: 82472 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1458 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T08:30:07.296103Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [5:1538:2430], Recipient [4:543:2450]: NKikimrTxDataShard.TEvPeriodicTableStats DatashardId: 72075186224037890 TableLocalId: 3 Generation: 1 Round: 1 TableStats { DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1523 LastUpdateTime: 1523 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0 } TabletMetrics { Memory: 82472 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1458 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T08:30:07.296166Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-11-14T08:30:07.296240Z node 4 :FLAT_TX_SCHEMESHARD INFO: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] state 'Ready' dataSize 75 rowCount 1 cpuUsage 0
2025-11-14T08:30:07.296422Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] raw table stats:
DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1523 LastUpdateTime: 1523 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 0 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0
2025-11-14T08:30:07.296483Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.100000s, queue# 1
2025-11-14T08:30:07.378779Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715661. Ctx: { TraceId: 01ka0qrvy44r55c5s0p28s955w, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=NmIzOTYwNDItNzZhNTVhNTQtNTZlMDYyYS05OTg2YTFkNA==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-11-14T08:30:07.380201Z node 5 :TX_DATASHARD ERROR: Cannot perform writes: database is out of disk space
2025-11-14T08:30:07.380324Z node 5 :TX_DATASHARD ERROR: Prepare transaction failed. txid 281474976715661 at tablet 72075186224037890 errors: DISK_SPACE_EXHAUSTED (Cannot perform writes: database is out of disk space) |
2025-11-14T08:30:07.380428Z node 5 :TX_DATASHARD ERROR: Errors while proposing transaction txid 281474976715661 at tablet 72075186224037890 status: ERROR errors: DISK_SPACE_EXHAUSTED (Cannot perform writes: database is out of disk space) |
2025-11-14T08:30:07.380955Z node 4 :KQP_EXECUTER ERROR: ActorId: [4:1828:3105] TxId: 281474976715661. Ctx: { TraceId: 01ka0qrvy44r55c5s0p28s955w, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=NmIzOTYwNDItNzZhNTVhNTQtNTZlMDYyYS05OTg2YTFkNA==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. ERROR: [DISK_SPACE_EXHAUSTED] Cannot perform writes: database is out of disk space; 
2025-11-14T08:30:07.391185Z node 4 :KQP_SESSION WARN: SessionId: ydb://session/3?node_id=4&id=NmIzOTYwNDItNzZhNTVhNTQtNTZlMDYyYS05OTg2YTFkNA==, ActorId: [4:1818:3105], ActorState: ExecuteState, TraceId: 01ka0qrvy44r55c5s0p28s955w, Create QueryResponse for error on request, msg: 
2025-11-14T08:30:07.392207Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715662. Ctx: { TraceId: 01ka0qrvy44r55c5s0p28s955w, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=NmIzOTYwNDItNzZhNTVhNTQtNTZlMDYyYS05OTg2YTFkNA==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
2025-11-14T08:30:07.482034Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T08:30:07.482140Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T08:30:07.482193Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 1
2025-11-14T08:30:07.482306Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will execute TTxStoreStats, queue# 1
2025-11-14T08:30:07.482367Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.000000s, queue# 1
2025-11-14T08:30:07.482534Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: PersistSingleStats for pathId 3 shard idx 72057594046644480:3 data size 75 row count 1
2025-11-14T08:30:07.482625Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxStoreTableStats.PersistSingleStats: main stats from datashardId(TabletID)=72075186224037890 maps to shardIdx: 72057594046644480:3 followerId=0, pathId: [OwnerId: 72057594046644480, LocalPathId: 3], pathId map=table, is column=0, is olap=0
2025-11-14T08:30:07.482723Z node 4 :FLAT_TX_SCHEMESHARD INFO: Add stats from shard with datashardId(TabletID)=72075186224037890 followerId=0, pathId 3: RowCount 1, DataSize 75
2025-11-14T08:30:07.482772Z node 4 :FLAT_TX_SCHEMESHARD TRACE: BuildStatsForCollector: datashardId 72075186224037890, followerId 0
2025-11-14T08:30:07.482859Z node 4 :FLAT_TX_SCHEMESHARD TRACE: [BackgroundCompaction] [Update] Skipped shard# 72057594046644480:3 with partCount# 1, rowCount# 1, searchHeight# 1, lastFullCompaction# 1970-01-01T00:00:01.000000Z at schemeshard 72057594046644480
2025-11-14T08:30:07.483386Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72057594046644480
2025-11-14T08:30:07.483446Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72057594046644480, txId: 0, path id: [OwnerId: 72057594046644480, LocalPathId: 2]
2025-11-14T08:30:07.488470Z node 4 :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72057594046644480
2025-11-14T08:30:07.488558Z node 4 :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72057594046644480
2025-11-14T08:30:07.488613Z node 4 :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [4:754:2600], at schemeshard: 72057594046644480, txId: 0, path id: 2
2025-11-14T08:30:07.489487Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [4:754:2600], Recipient [4:543:2450]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72057594046644480 Generation: 2 PathId: [OwnerId: 72057594046644480, LocalPathId: 2] Version: 8 }
2025-11-14T08:30:07.489547Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-11-14T08:30:07.489649Z node 4 :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72057594046644480, msg: Owner: 72057594046644480 Generation: 2 LocalPathId: 2 Version: 8 PathOwnerId: 72057594046644480, cookie: 0
2025-11-14T08:30:07.502086Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435090, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvPrivate::TEvPersistTableStats
2025-11-14T08:30:07.502163Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvPersistTableStats
2025-11-14T08:30:07.502195Z node 4 :FLAT_TX_SCHEMESHARD INFO: Started TEvPersistStats at tablet 72057594046644480, queue size# 0
2025-11-14T08:30:07.843505Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:07.843585Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:07.843670Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:07.843698Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:08.590570Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:08.590677Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:08.590795Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:08.590828Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:09.350026Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:09.350108Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:09.350214Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:09.350241Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:10.167425Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:10.167506Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:10.167640Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:10.167684Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:10.981772Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:10.981843Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-11-14T08:30:10.981935Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [4:543:2450], Recipient [4:543:2450]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-11-14T08:30:10.981962Z 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: 82472 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1458 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T08:30:11.296503Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269553162, Sender [5:1538:2430], Recipient [4:543:2450]: NKikimrTxDataShard.TEvPeriodicTableStats DatashardId: 72075186224037890 TableLocalId: 3 Generation: 1 Round: 2 TableStats { DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1523 LastUpdateTime: 1523 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 1 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0 } TabletMetrics { Memory: 82472 } ShardState: 2 UserTablePartOwners: 72075186224037890 NodeId: 5 StartTime: 1458 TableOwnerId: 72057594046644480 FollowerId: 0
2025-11-14T08:30:11.296567Z node 4 :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvPeriodicTableStats
2025-11-14T08:30:11.296623Z node 4 :FLAT_TX_SCHEMESHARD INFO: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] state 'Ready' dataSize 75 rowCount 1 cpuUsage 0
2025-11-14T08:30:11.296772Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Got periodic table stats at tablet 72057594046644480 from shard 72075186224037890 followerId 0 pathId [OwnerId: 72057594046644480, LocalPathId: 3] raw table stats:
DataSize: 75 RowCount: 1 IndexSize: 0 InMemSize: 0 LastAccessTime: 1523 LastUpdateTime: 1523 ImmediateTxCompleted: 1 PlannedTxCompleted: 1 TxRejectedByOverload: 0 TxRejectedBySpace: 1 TxCompleteLagMsec: 0 InFlightTxCount: 0 RowUpdates: 1 RowDeletes: 0 RowReads: 0 RangeReads: 0 PartCount: 1 RangeReadRows: 0 SearchHeight: 1 LastFullCompactionTs: 1 HasLoanedParts: false Channels { Channel: 1 DataSize: 30 IndexSize: 0 } Channels { Channel: 2 DataSize: 45 IndexSize: 0 } ByKeyFilterSize: 0 HasSchemaChanges: false LocksAcquired: 0 LocksWholeShard: 0 LocksBroken: 0
2025-11-14T08:30:11.296816Z node 4 :FLAT_TX_SCHEMESHARD TRACE: Will delay TTxStoreTableStats on# 0.100000s, queue# 1
2025-11-14T08:30:11.357057Z node 4 :KQP_EXECUTER ERROR: TxId: 281474976715663. Ctx: { TraceId: 01ka0qrzv45x692vat5avvn1t5, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=4&id=MmE2MjZiYWYtYTBiOTUzYWUtNzIyN2NjYTgtNzJkMDc2MmU=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. Database not set, use /Root
