2025-10-26T19:04:02.874069Z :BOOTSTRAPPER NOTICE: tablet: 72057594037936131, type: Console, boot
2025-10-26T19:04:02.875670Z :BOOTSTRAPPER NOTICE: tablet: 72057594037968897, type: Hive, boot
2025-10-26T19:04:02.875774Z :BOOTSTRAPPER NOTICE: tablet: 72057594037932033, type: BSController, boot
2025-10-26T19:04:02.875878Z :BOOTSTRAPPER NOTICE: tablet: 72057594046316545, type: Coordinator, boot
2025-10-26T19:04:02.875930Z :BOOTSTRAPPER NOTICE: tablet: 72057594046382081, type: Mediator, boot
2025-10-26T19:04:02.960651Z :BOOTSTRAPPER NOTICE: tablet: 72075186232723360, type: SchemeShard, boot
2025-10-26T19:04:02.960737Z :BOOTSTRAPPER NOTICE: tablet: 72057594046447617, type: TxAllocator, boot
2025-10-26T19:04:02.960768Z :BOOTSTRAPPER NOTICE: tablet: 72057594037936128, type: Cms, boot
2025-10-26T19:04:02.960793Z :BOOTSTRAPPER NOTICE: tablet: 72057594037936129, type: NodeBroker, boot
2025-10-26T19:04:02.961025Z :BS_NODE WARN: {NW89@node_warden_pdisk.cpp:101} Can't write new MockDevicesConfig to file Path# /Berkanavt/kikimr/testing/mock_devices.txt
2025-10-26T19:04:02.966352Z :BOOTSTRAPPER NOTICE: tablet: 72057594037936130, type: TenantSlotBroker, boot
2025-10-26T19:04:02.986059Z :MEMORY_PROFILER NOTICE: Bootstrapped
2025-10-26T19:04:03.081343Z :BS_PROXY NOTICE: EnsureMonitoring Group# 0 IsLimitedKeyless# 0 fullIfPossible# 0 Marker# DSP58
2025-10-26T19:04:03.084958Z :BS_PROXY NOTICE: Group# 4294967295 HasInvalidGroupId# 1 Bootstrap -> StateEjected Marker# DSP42
2025-10-26T19:04:03.087370Z :BS_LOCALRECOVERY NOTICE: VDISK[0:_:0:0:0]: LocalRecovery START
2025-10-26T19:04:03.087790Z :TENANT_POOL NOTICE: TDomainTenantPool(Root) started tenant /Root
2025-10-26T19:04:03.468564Z :TX_CONVEYOR NOTICE: fline=service.cpp:16;name=Scan;action=conveyor_registered;config=QueueSizeLimit=262144;Enabled=1;;
2025-10-26T19:04:03.486969Z :BLOB_CACHE NOTICE: MaxCacheDataSize: 1048576000 InFlightDataSize: 0
2025-10-26T19:04:03.487094Z :GRPC_SERVER NOTICE: Grpc request proxy started, nodeid# 1, serve as static node
2025-10-26T19:04:03.487493Z :GRPC_SERVER NOTICE: Grpc request proxy started, nodeid# 1, serve as static node
2025-10-26T19:04:03.489314Z :TX_CONVEYOR NOTICE: fline=service.cpp:16;name=Comp;action=conveyor_registered;config=DefaultFractionOfThreadsCount=0.33;QueueSizeLimit=262144;Enabled=1;;
2025-10-26T19:04:03.489545Z :TX_CONVEYOR NOTICE: fline=service.cpp:16;name=Isrt;action=conveyor_registered;config=DefaultFractionOfThreadsCount=0.2;QueueSizeLimit=262144;Enabled=1;;
2025-10-26T19:04:03.498854Z :PGWIRE ERROR: Failed to bind [::]:5432. Error: Address already in use
2025-10-26T19:04:03.547286Z :BS_PDISK NOTICE: PDiskId# 1 OnDriveStartup  Path# "SectorMap:1:64" Marker# BPD38
2025-10-26T19:04:03.548808Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][1:7565608269984947702:4149][/Root] Set up state: owner# [1:7565608265689980208:8], state# { Deleted: 1 Strong: 0 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T19:04:03.548876Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][1:7565608269984947703:4150][/Root] Set up state: owner# [1:7565608265689980209:16], state# { Deleted: 1 Strong: 0 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T19:04:03.548926Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][1:7565608269984947725:4165][/Root] Set up state: owner# [1:7565608269984947682:4122], state# { Deleted: 1 Strong: 0 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T19:04:03.548985Z :GRPC_SERVER WARN: SchemeBoardDelete /Root Strong=0
2025-10-26T19:04:03.549008Z :GRPC_SERVER WARN: SchemeBoardDelete /Root Strong=0
2025-10-26T19:04:03.549307Z :METADATA_PROVIDER ERROR: fline=accessor_snapshot_base.cpp:68;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=incorrect path status: LookupError;
2025-10-26T19:04:03.549354Z :METADATA_PROVIDER ERROR: fline=accessor_snapshot_base.cpp:68;action=cannot detect path existence;path=//Root/.metadata/cs_index/external;error=incorrect path status: LookupError;
2025-10-26T19:04:03.558301Z :BS_PDISK NOTICE: PDiskId# 1 shutdown owner info# { PDisk system/log ChunkIds: {} Free ChunkIds: {}
2025-10-26T19:04:03.601930Z :BS_PDISK WARN: PDiskId# 1Magic sector is present on disk, now going to format device
2025-10-26T19:04:04.503165Z :BS_PDISK NOTICE: PDiskId# 1 OnDriveStartup  Path# "SectorMap:1:64" Marker# BPD38
2025-10-26T19:04:04.503240Z :BS_PDISK WARN: PDiskId# 1 device formatting done
2025-10-26T19:04:04.510051Z :BS_PDISK NOTICE: PDiskId# 1 Successfully read format record# {TDiskFormat Version: 3 DiskSize: 68719476736 bytes (68 GB) Guid: 1 MagicNextLogChunkReference: 2103588909583409837 MagicLogChunk: 6953459420659049505 MagicDataChunk: 3568197108350765124 MagicSysLogChunk: 12594699600636422186 MagicFormatChunk: 17332287817462050952 ChunkSize: 35651584 bytes (35 MB) SectorSize: 4096 SysLogSectorCount: 112 SystemChunkCount: 1 FormatText: "" DiskFormatSize: 1168 (current sizeof: 1168) TimestampUs: 1761505443964874 (2025-10-26T19:04:03.964874Z) FormatFlags: {ErasureEncodeSysLog | ErasureEncodeFormat | ErasureEncodeNextChunkReference | EncryptFormat | EncryptData}}
2025-10-26T19:04:04.552768Z :BS_PDISK NOTICE: PDiskId# 1 Read SysLogRecord# {TSysLogRecord Version# 7 NonceSet# {TNonceSet Version# 0 NonceSysLog# 106 NonceLog# 1 NonceData# 1} LogHeadChunkIdx# 1 LogHeadChunkPreviousNonce# 0}
2025-10-26T19:04:04.558297Z :METADATA_PROVIDER ERROR: fline=accessor_snapshot_base.cpp:68;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=incorrect path status: LookupError;
2025-10-26T19:04:04.558356Z :METADATA_PROVIDER ERROR: fline=accessor_snapshot_base.cpp:68;action=cannot detect path existence;path=//Root/.metadata/cs_index/external;error=incorrect path status: LookupError;
2025-10-26T19:04:04.561787Z :BS_PDISK NOTICE: PDiskId# 1 LogReader IsInitial# 1 ChunkIdx# 1 SectorIdx# 0 OffsetInSector# 0 In ProcessSectorSet got !restorator.GoodSectorFlags ! LastGoodToWriteLogPosition# { ChunkIdx# 1 OffsetInChunk# 0} Marker# LR018
2025-10-26T19:04:04.563264Z :BS_PDISK NOTICE: PDiskId# 1 Successfully started
2025-10-26T19:04:04.564352Z :BS_PDISK NOTICE: PDiskId# 1 new owner is created. ownerId# 3 vDiskId# [0:_:0:0:0] FirstNonceToKeep# 1367209 CutLogId# [1:7565608269984947635:38] ownerRound# 3 Marker# BPD02
2025-10-26T19:04:04.590979Z :BS_LOCALRECOVERY NOTICE: VDISK[0:_:0:0:0]: MAX LSNS: LogoBlobs# [ExplicitlySet# true Derived# false Lsn# NotSet] Blocks# [ExplicitlySet# true Derived# false Lsn# NotSet] Barriers# [ExplicitlySet# true Derived# false Lsn# NotSet] SyncLog# 0
2025-10-26T19:04:04.591296Z :BS_LOCALRECOVERY NOTICE: VDISK[0:_:0:0:0]: TRecoveryLogReplayer: START
2025-10-26T19:04:04.593164Z :BS_LOCALRECOVERY NOTICE: VDISK[0:_:0:0:0]: LocalRecovery FINISHED: {RecoveryDuration# 1.505039s RecoveredLogStartLsn# 0 SuccessfulRecovery# true EmptyLogoBlobsDb# true EmptyBlocksDb# true EmptyBarriersDb# true EmptySyncLog# true EmptySyncer# true EmptyHuge# true LogRecLogoBlob# 0 LogRecBlock# 0 LogRecGC# 0 LogRecSyncLogIdx# 0 LogRecLogoBlobsDB# 0 LogRecBlocksDB# 0 LogRecBarriersDB# 0 LogRecCutLog# 0 LogRecLocalSyncData# 0 LogRecSyncerState# 0 LogRecHandoffDel# 0 LogRecHugeBlobAllocChunk# 0 LogRecHugeBlobFreeChunk# 0 LogRecHugeBlobEntryPoint# 0 LogRecHugeLogoBlob# 0 LogRecLogoBlobOpt# 0 LogRecPhantomBlob# 0 LogRecAnubisOsirisPut# 0 LogRecAddBulkSst# 0 LogoBlobFreshApply# 0 LogoBlobFreshSkip# 0 LogoBlobsBatchFreshApply# 0 LogoBlobsBatchFreshSkip#0 LogoBlobSyncLogApply# 0 LogoBlobSyncLogSkip# 0 HugeLogoBlobFreshApply# 0 HugeLogoBlobFreshSkip# 0 HugeLogoBlobSyncLogApply# 0 HugeLogoBlobSyncLogSkip# 0 BlockFreshApply# 0 BlockFreshSkip# 0 BlocksBatchFreshApply# 0 BlocksBatchFreshSkip# 0 BlockSyncLogApply# 0 BlockSyncLogSkip# 0 BarrierFreshApply# 0 BarrierFreshSkip# 0 BarriersBatchFreshApply# 0 BarriersBatchFreshSkip# 0 BarrierSyncLogApply# 0 BarrierSyncLogSkip# 0 GCBarrierFreshApply# 0 GCBarrierFreshSkip# 0 GCLogoBlobFreshApply# 0 GCLogoBlobFreshSkip# 0 GCSyncLogApply# 0 GCSyncLogSkip# 0 TryPutLogoBlobSyncData# 0 TryPutBlockSyncData# 0 TryPutBarrierSyncData# 0 HandoffDelFreshApply# 0 HandoffDelFreshSkip# 0 HugeBlobAllocChunkApply# 0 HugeBlobAllocChunkSkip# 0 HugeBlobFreeChunkApply# 0 HugeBlobFreeChunkSkip# 0 HugeLogoBlobToHeapApply# 0 HugeLogoBlobToHeapSkip# 0 HugeSlotsDelGenericApply# 0 HugeSlotsDelGenericSkip# 0 TryPutLogoBlobPhantom# 0 RecoveryLogDiapason# [18446744073709551615 0] StartingPoints# {} ReadLogReplies# {{RecsN# 0 Lsns# [0 0]}}}
2025-10-26T19:04:04.603068Z :BS_PROXY NOTICE: EnsureMonitoring Group# 0 IsLimitedKeyless# 0 Marker# DSP57 initialize full monitoring
2025-10-26T19:04:04.608555Z :BS_PROXY_DISCOVER WARN: [988c0e0bfb01fa13] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.608571Z :BS_PROXY_DISCOVER WARN: [8047b80ccf2f6b25] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.608692Z :BS_PROXY_DISCOVER WARN: [a76c4acca00a033b] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.608735Z :BS_PROXY_DISCOVER WARN: [6b9f2bcadaee05ee] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.608785Z :BS_PROXY_DISCOVER WARN: [f442876059c6a68a] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.608850Z :BS_PROXY_DISCOVER WARN: [31dbe111525392cc] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.608879Z :BS_PROXY_DISCOVER WARN: [07d2be798af134de] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.608981Z :BS_PROXY_DISCOVER WARN: [173cd26aca50b35c] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.609003Z :BS_PROXY_DISCOVER WARN: [f46672dcee87c45d] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.609131Z :BS_PROXY_DISCOVER WARN: [1a73ad11e8ed193d] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.660079Z :BS_PROXY_DISCOVER WARN: [e977968ba39eedc0] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 1 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.660215Z :BS_PROXY_DISCOVER WARN: [dae6608ac6d95ed5] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 1 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.661823Z :BS_PROXY_DISCOVER WARN: [96e701fa7eb2244d] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 1 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.662327Z :BS_PROXY_DISCOVER WARN: [10a9e454d33b84b4] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 1 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.662471Z :BS_PROXY_DISCOVER WARN: [e74abb95e1d9095a] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 1 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.662591Z :BS_PROXY_DISCOVER WARN: [6c15a03c4e37a871] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 1 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.663150Z :BS_PROXY_DISCOVER WARN: [c8704790c5d0ea72] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 1 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.664214Z :BS_PROXY_DISCOVER WARN: [1902e0ccf83b1644] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 1 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.666431Z :BS_PROXY_DISCOVER WARN: [46bd45dc182539f6] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 1 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.826200Z :TX_COORDINATOR NOTICE: tablet# 72057594046316545 HANDLE EvMediatorQueueRestart MediatorId# 72057594046382081
2025-10-26T19:04:04.846932Z :BS_PROXY_DISCOVER WARN: [426f9fc44b18d004] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 1 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:04:04.883635Z :FLAT_TX_SCHEMESHARD NOTICE: BackgroundCompactionQueue configured: Timeout# 600.000000s, compact single parted# no, Rate# 1, WakeupInterval# 60.000000s, RoundInterval# 172800.000000s, InflightLimit# 1, MinCompactionRepeatDelaySeconds# 600.000000s, MaxRate# 1
2025-10-26T19:04:04.883692Z :FLAT_TX_SCHEMESHARD NOTICE: BorrowedCompactionQueue configured: Timeout# 15.000000s, Rate# 0, WakeupInterval# 1.000000s, InflightLimit# 10
2025-10-26T19:04:04.883729Z :FLAT_TX_SCHEMESHARD NOTICE: StatsBatching config: StatsBatchTimeout# 0.100000s, StatsMaxBatchSize# 100, StatsMaxExecuteTime# 0.010000s
2025-10-26T19:04:04.883761Z :FLAT_TX_SCHEMESHARD NOTICE: OperationsProcessing config: using default configuration
2025-10-26T19:04:04.883797Z :FLAT_TX_SCHEMESHARD NOTICE: OperationsProcessing config: type TxMergeTablePartition, limit 10000
2025-10-26T19:04:04.883815Z :FLAT_TX_SCHEMESHARD NOTICE: OperationsProcessing config: type TxSplitTablePartition, limit 10000
2025-10-26T19:04:04.883852Z :FLAT_TX_SCHEMESHARD NOTICE: BackgroundCleaningQueue configured: Timeout# 15.000000s, Rate# 0, WakeupInterval# 1.000000s, InflightLimit# 10
2025-10-26T19:04:04.885735Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything::Execute
2025-10-26T19:04:04.886570Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything loaded 0 sequences
2025-10-26T19:04:04.887959Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything loaded 0 subdomains
2025-10-26T19:04:04.888015Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything loaded 0 blocked owners
2025-10-26T19:04:04.888076Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything loaded 0 nodes
2025-10-26T19:04:04.888199Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything loaded 0 tablet categories
2025-10-26T19:04:04.890052Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything loaded 0 tablets
2025-10-26T19:04:04.890149Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything loaded 0 tablet/channel pairs (0 for missing tablets)
2025-10-26T19:04:04.890304Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything loaded 0 tablet/channel history items (0 for missing tablets)
2025-10-26T19:04:04.890361Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything initialized allocation units for 0 tablets
2025-10-26T19:04:04.890410Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything loaded 0 tablet follower groups (0 for missing tablets)
2025-10-26T19:04:04.890452Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything loaded 0 tablet followers (0 for missing tablets)
2025-10-26T19:04:04.890509Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything loaded 0 metrics (0 for missing tablets)
2025-10-26T19:04:04.890556Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything loaded 0 tablet availability restrictions (0 for missing nodes)
2025-10-26T19:04:04.890580Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything deleted 0 unnecessary nodes << (and 0 restrictions for them)
2025-10-26T19:04:04.898607Z :HIVE NOTICE: HIVE#72057594037968897 THive::TTxLoadEverything::Complete 
2025-10-26T19:04:04.939034Z :HIVE WARN: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-10-26T19:04:04.939200Z :HIVE WARN: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-10-26T19:04:04.945261Z :HIVE WARN: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-10-26T19:04:05.015362Z :FLAT_TX_SCHEMESHARD NOTICE: UpgradeInitState as Uninitialized, schemeshardId: 72075186232723360
2025-10-26T19:04:05.015917Z :FLAT_TX_SCHEMESHARD NOTICE: Subscription to Console has been set up, schemeshardId: 72075186232723360
2025-10-26T19:04:05.036151Z :FLAT_TX_SCHEMESHARD NOTICE: TTxInit, SS hasn't been configured yet, state: 1, at schemeshard: 72075186232723360
2025-10-26T19:04:05.036412Z :FLAT_TX_SCHEMESHARD NOTICE: TTxInitRoot DoExecute, path: Root, pathId: [OwnerId: 72075186232723360, LocalPathId: 1], at schemeshard: 72075186232723360
2025-10-26T19:04:05.054920Z :FLAT_TX_SCHEMESHARD NOTICE: TTxInitRoot DoComplete, at schemeshard: 72075186232723360
2025-10-26T19:04:05.055689Z :FLAT_TX_SCHEMESHARD NOTICE: TTxServerlessStorageBilling: unable to make a bill, domain is not a serverless db, schemeshardId: 72075186232723360, domainId: [OwnerId: 72075186232723360, LocalPathId: 1]
2025-10-26T19:04:05.058543Z :SCHEME_BOARD_REPLICA NOTICE: [1:7565608265689980167:4110] Successful handshake: owner# 72075186232723360, generation# 2
2025-10-26T19:04:05.062841Z :SCHEME_BOARD_POPULATOR NOTICE: [1:7565608278574882695:68] Successful handshake: replica# [1:7565608265689980167:4110]
2025-10-26T19:04:05.062873Z :SCHEME_BOARD_POPULATOR NOTICE: [1:7565608278574882695:68] Start full sync: replica# [1:7565608265689980167:4110]
2025-10-26T19:04:05.064831Z :SCHEME_BOARD_REPLICA NOTICE: [1:7565608265689980167:4110] Update description: path# /Root, pathId# [OwnerId: 72075186232723360, LocalPathId: 1], deletion# false
2025-10-26T19:04:05.069345Z :SCHEME_BOARD_REPLICA NOTICE: [1:7565608265689980167:4110] Commit generation: owner# 72075186232723360, generation# 2
2025-10-26T19:04:05.069432Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][1:7565608269984947702:4149][/Root] Update to strong state: owner# [1:7565608265689980208:8], state# { Deleted: 1 Strong: 0 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 2) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }
2025-10-26T19:04:05.069594Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][1:7565608269984947725:4165][/Root] Update to strong state: owner# [1:7565608269984947682:4122], state# { Deleted: 1 Strong: 0 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 2) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }
2025-10-26T19:04:05.069700Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][1:7565608269984947703:4150][/Root] Update to strong state: owner# [1:7565608265689980209:16], state# { Deleted: 1 Strong: 0 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 2) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }
2025-10-26T19:04:05.527721Z :IMPORT WARN: Table profiles were not loaded
2025-10-26T19:04:05.564826Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][1:7565608278574882724:4197][/Root/.metadata/initialization/migrations] Set up state: owner# [1:7565608269984947682:4122], state# { Deleted: 1 Strong: 1 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T19:04:05.564880Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][1:7565608278574882725:4168][/Root/.metadata/cs_index/external] Set up state: owner# [1:7565608269984947682:4122], state# { Deleted: 1 Strong: 1 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T19:04:05.584594Z :NET_CLASSIFIER WARN: distributable config is empty, broken or outdated, will use file: /home/runner/.ya/build/build_root/70hy/000aa8/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_self_heal/chunk0/testing_out_stuff/netData.tsv
2025-10-26T19:04:05.584634Z :NET_CLASSIFIER WARN: will try to initialize from file: /home/runner/.ya/build/build_root/70hy/000aa8/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_self_heal/chunk0/testing_out_stuff/netData.tsv
2025-10-26T19:04:05.584771Z :NET_CLASSIFIER WARN: successfully initialized from file: /home/runner/.ya/build/build_root/70hy/000aa8/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_self_heal/chunk0/testing_out_stuff/netData.tsv
2025-10-26T19:04:05.584956Z :NET_CLASSIFIER ERROR: got bad distributable configuration
2025-10-26T19:04:05.604998Z :CMS NOTICE: [AuditLog] [CMS tablet] Reply: request# NKikimr::NCms::TEvCms::TEvClusterStateRequest {  }, response# NKikimr::NCms::TEvCms::TEvClusterStateResponse { Status { Code: OK } State { Hosts { Name: "localhost" State: UP Services { Name: "storage" State: UP Version: ".fdf4d71" Timestamp: 1761505445602422 } Devices { Name: "vdisk-0-1-0-0-0" State: UP Timestamp: 1761505445602422 } Devices { Name: "pdisk-1-1" State: UP Timestamp: 1761505445602422 } Timestamp: 1761505445602422 NodeId: 1 InterconnectPort: 28961 Location { DataCenter: "1" Rack: "1" Unit: "1" } StartTimeSeconds: 1761505442 } Timestamp: 1761505445602422 } }
2025-10-26T19:04:06.651801Z :BS_CONTROLLER NOTICE: {BSCFP02@config_fit_pdisks.cpp:356} Create new pdisk PDiskId# 1:1 Path# SectorMap:1:64
2025-10-26T19:04:07.809870Z :BS_LOCALRECOVERY NOTICE: VDISK[82000001:_:0:0:0]: LocalRecovery START
2025-10-26T19:04:07.810692Z :BS_PDISK NOTICE: PDiskId# 1 new owner is created. ownerId# 4 vDiskId# [82000001:_:0:0:0] FirstNonceToKeep# 1367264 CutLogId# [1:7565608287164817362:74] ownerRound# 5 Marker# BPD02
2025-10-26T19:04:07.820309Z :BS_LOCALRECOVERY NOTICE: VDISK[82000000:_:0:0:0]: LocalRecovery START
2025-10-26T19:04:07.821091Z :BS_PDISK NOTICE: PDiskId# 1 new owner is created. ownerId# 5 vDiskId# [82000000:_:0:0:0] FirstNonceToKeep# 1367265 CutLogId# [1:7565608287164817367:101] ownerRound# 4 Marker# BPD02
2025-10-26T19:04:07.834100Z :BS_LOCALRECOVERY NOTICE: VDISK[82000001:_:0:0:0]: MAX LSNS: LogoBlobs# [ExplicitlySet# true Derived# false Lsn# NotSet] Blocks# [ExplicitlySet# true Derived# false Lsn# NotSet] Barriers# [ExplicitlySet# true Derived# false Lsn# NotSet] SyncLog# 0
2025-10-26T19:04:07.834323Z :BS_LOCALRECOVERY NOTICE: VDISK[82000001:_:0:0:0]: TRecoveryLogReplayer: START
2025-10-26T19:04:07.838488Z :BS_LOCALRECOVERY NOTICE: VDISK[82000001:_:0:0:0]: LocalRecovery FINISHED: {RecoveryDuration# 0.028618s RecoveredLogStartLsn# 0 SuccessfulRecovery# true EmptyLogoBlobsDb# true EmptyBlocksDb# true EmptyBarriersDb# true EmptySyncLog# true EmptySyncer# true EmptyHuge# true LogRecLogoBlob# 0 LogRecBlock# 0 LogRecGC# 0 LogRecSyncLogIdx# 0 LogRecLogoBlobsDB# 0 LogRecBlocksDB# 0 LogRecBarriersDB# 0 LogRecCutLog# 0 LogRecLocalSyncData# 0 LogRecSyncerState# 0 LogRecHandoffDel# 0 LogRecHugeBlobAllocChunk# 0 LogRecHugeBlobFreeChunk# 0 LogRecHugeBlobEntryPoint# 0 LogRecHugeLogoBlob# 0 LogRecLogoBlobOpt# 0 LogRecPhantomBlob# 0 LogRecAnubisOsirisPut# 0 LogRecAddBulkSst# 0 LogoBlobFreshApply# 0 LogoBlobFreshSkip# 0 LogoBlobsBatchFreshApply# 0 LogoBlobsBatchFreshSkip#0 LogoBlobSyncLogApply# 0 LogoBlobSyncLogSkip# 0 HugeLogoBlobFreshApply# 0 HugeLogoBlobFreshSkip# 0 HugeLogoBlobSyncLogApply# 0 HugeLogoBlobSyncLogSkip# 0 BlockFreshApply# 0 BlockFreshSkip# 0 BlocksBatchFreshApply# 0 BlocksBatchFreshSkip# 0 BlockSyncLogApply# 0 BlockSyncLogSkip# 0 BarrierFreshApply# 0 BarrierFreshSkip# 0 BarriersBatchFreshApply# 0 BarriersBatchFreshSkip# 0 BarrierSyncLogApply# 0 BarrierSyncLogSkip# 0 GCBarrierFreshApply# 0 GCBarrierFreshSkip# 0 GCLogoBlobFreshApply# 0 GCLogoBlobFreshSkip# 0 GCSyncLogApply# 0 GCSyncLogSkip# 0 TryPutLogoBlobSyncData# 0 TryPutBlockSyncData# 0 TryPutBarrierSyncData# 0 HandoffDelFreshApply# 0 HandoffDelFreshSkip# 0 HugeBlobAllocChunkApply# 0 HugeBlobAllocChunkSkip# 0 HugeBlobFreeChunkApply# 0 HugeBlobFreeChunkSkip# 0 HugeLogoBlobToHeapApply# 0 HugeLogoBlobToHeapSkip# 0 HugeSlotsDelGenericApply# 0 HugeSlotsDelGenericSkip# 0 TryPutLogoBlobPhantom# 0 RecoveryLogDiapason# [18446744073709551615 0] StartingPoints# {} ReadLogReplies# {{RecsN# 0 Lsns# [0 0]}}}
2025-10-26T19:04:07.841002Z :BS_LOCALRECOVERY NOTICE: VDISK[82000000:_:0:0:0]: MAX LSNS: LogoBlobs# [ExplicitlySet# true Derived# false Lsn# NotSet] Blocks# [ExplicitlySet# true Derived# false Lsn# NotSet] Barriers# [ExplicitlySet# true Derived# false Lsn# NotSet] SyncLog# 0
2025-10-26T19:04:07.841638Z :BS_LOCALRECOVERY NOTICE: VDISK[82000000:_:0:0:0]: TRecoveryLogReplayer: START
2025-10-26T19:04:07.842165Z :BS_LOCALRECOVERY NOTICE: VDISK[82000000:_:0:0:0]: LocalRecovery FINISHED: {RecoveryDuration# 0.021847s RecoveredLogStartLsn# 0 SuccessfulRecovery# true EmptyLogoBlobsDb# true EmptyBlocksDb# true EmptyBarriersDb# true EmptySyncLog# true EmptySyncer# true EmptyHuge# true LogRecLogoBlob# 0 LogRecBlock# 0 LogRecGC# 0 LogRecSyncLogIdx# 0 LogRecLogoBlobsDB# 0 LogRecBlocksDB# 0 LogRecBarriersDB# 0 LogRecCutLog# 0 LogRecLocalSyncData# 0 LogRecSyncerState# 0 LogRecHandoffDel# 0 LogRecHugeBlobAllocChunk# 0 LogRecHugeBlobFreeChunk# 0 LogRecHugeBlobEntryPoint# 0 LogRecHugeLogoBlob# 0 LogRecLogoBlobOpt# 0 LogRecPhantomBlob# 0 LogRecAnubisOsirisPut# 0 LogRecAddBulkSst# 0 LogoBlobFreshApply# 0 LogoBlobFreshSkip# 0 LogoBlobsBatchFreshApply# 0 LogoBlobsBatchFreshSkip#0 LogoBlobSyncLogApply# 0 LogoBlobSyncLogSkip# 0 HugeLogoBlobFreshApply# 0 HugeLogoBlobFreshSkip# 0 HugeLogoBlobSyncLogApply# 0 HugeLogoBlobSyncLogSkip# 0 BlockFreshApply# 0 BlockFreshSkip# 0 BlocksBatchFreshApply# 0 BlocksBatchFreshSkip# 0 BlockSyncLogApply# 0 BlockSyncLogSkip# 0 BarrierFreshApply# 0 BarrierFreshSkip# 0 BarriersBatchFreshApply# 0 BarriersBatchFreshSkip# 0 BarrierSyncLogApply# 0 BarrierSyncLogSkip# 0 GCBarrierFreshApply# 0 GCBarrierFreshSkip# 0 GCLogoBlobFreshApply# 0 GCLogoBlobFreshSkip# 0 GCSyncLogApply# 0 GCSyncLogSkip# 0 TryPutLogoBlobSyncData# 0 TryPutBlockSyncData# 0 TryPutBarrierSyncData# 0 HandoffDelFreshApply# 0 HandoffDelFreshSkip# 0 HugeBlobAllocChunkApply# 0 HugeBlobAllocChunkSkip# 0 HugeBlobFreeChunkApply# 0 HugeBlobFreeChunkSkip# 0 HugeLogoBlobToHeapApply# 0 HugeLogoBlobToHeapSkip# 0 HugeSlotsDelGenericApply# 0 HugeSlotsDelGenericSkip# 0 TryPutLogoBlobPhantom# 0 RecoveryLogDiapason# [18446744073709551615 0] StartingPoints# {} ReadLogReplies# {{RecsN# 0 Lsns# [0 0]}}}
2025-10-26T19:04:08.173525Z :FLAT_TX_SCHEMESHARD NOTICE: TAlterSubDomain Propose, path: //Root, opId: 281474976710657:0, at schemeshard: 72075186232723360
2025-10-26T19:04:08.183447Z :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976710657:0, propose status:StatusAccepted, reason: , at schemeshard: 72075186232723360
2025-10-26T19:04:08.183499Z :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 281474976710657:0, at schemeshard:  72075186232723360
2025-10-26T19:04:08.185856Z :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976710657, subject: , status: StatusAccepted, operation: ALTER DATABASE, path: //Root
2025-10-26T19:04:08.214318Z :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1761505448260, transactions count in step: 1, at schemeshard: 72075186232723360
2025-10-26T19:04:08.217715Z :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976710657:0
2025-10-26T19:04:08.217780Z :FLAT_TX_SCHEMESHARD NOTICE: Publication still in progress, tx: 281474976710657, publications: 1, subscribers: 1
2025-10-26T19:04:08.218058Z :SCHEME_BOARD_POPULATOR NOTICE: [1:7565608278574882693:4183] Update description: owner# 72075186232723360, pathId# [OwnerId: 72075186232723360, LocalPathId: 1], cookie# 281474976710657, is deletion# false, version: 3
2025-10-26T19:04:08.218536Z :SCHEME_BOARD_REPLICA NOTICE: [1:7565608265689980167:4110] Update description: path# /Root, pathId# [OwnerId: 72075186232723360, LocalPathId: 1], deletion# false
2025-10-26T19:04:08.219506Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][1:7565608269984947702:4149][/Root] Path was updated to new version: owner# [1:7565608265689980208:8], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 2) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 3) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }
2025-10-26T19:04:08.219670Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][1:7565608269984947725:4165][/Root] Path was updated to new version: owner# [1:7565608269984947682:4122], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 2) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 3) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }
2025-10-26T19:04:08.219739Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][1:7565608269984947703:4150][/Root] Path was updated to new version: owner# [1:7565608265689980209:16], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 2) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 3) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }
2025-10-26T19:04:08.220193Z :SCHEME_BOARD_POPULATOR NOTICE: [1:7565608278574882693:4183] Ack update: ack to# [1:7565608274279915334:94], cookie# 281474976710657, pathId# [OwnerId: 72075186232723360, LocalPathId: 1], version# 3
2025-10-26T19:04:08.220316Z :FLAT_TX_SCHEMESHARD NOTICE: Publication complete, notify & remove, at schemeshard: 72075186232723360, txId: 281474976710657, subscribers: 1
2025-10-26T19:04:08.312114Z :TENANT_POOL NOTICE: Forward drain node to local.
2025-10-26T19:04:08.312172Z :LOCAL NOTICE: Forward drain node to local, hive id: 72057594037968897
2025-10-26T19:04:08.312220Z :LOCAL NOTICE: Send drain node to hive: 72057594037968897. Online tablets: 0
2025-10-26T19:04:08.312816Z :GRPC_SERVER NOTICE: Stop publish endpoints for database: /Root
2025-10-26T19:04:08.318404Z :LOCAL NOTICE: Drain node result received. Online tablets: 0
2025-10-26T19:04:08.500618Z :IMPORT NOTICE: Load table profiles
2025-10-26T19:04:09.644004Z :KQP_PROXY NOTICE: KQP proxy shutdown requested.
2025-10-26T19:04:09.644897Z :KQP_SESSION NOTICE: SessionId: ydb://session/3?node_id=1&id=MzFiY2E1MWQtZmIzYWExMWMtNmZlMzg3YWEtZjJkOTRlYTk=, ActorId: [1:7565608295754752122:4212], ActorState: ExecuteState, TraceId: 01k8gyg5ncdnjeht6ka452z4xg, Started session shutdown
2025-10-26T19:04:09.813362Z :KQP_YQL NOTICE: TraceId: 01k8gyg5ncdnjeht6ka452z4xg, SessionId: CompileActor 2025-10-26 19:04:09.813 NOTE  ydbd(pid=1724377, tid=0x00007FAE73AE0640) [common provider] yql_provider_gateway.cpp:21: <main>: Error: Type annotation, code: 1030
2025-10-26T19:04:09.813426Z :KQP_YQL NOTICE: TraceId: 01k8gyg5ncdnjeht6ka452z4xg, SessionId: CompileActor 2025-10-26 19:04:09.813 NOTE  ydbd(pid=1724377, tid=0x00007FAE73AE0640) [common provider] yql_provider_gateway.cpp:21: <main>:3:16: Error: At function: KiReadTable!
2025-10-26T19:04:09.813626Z :KQP_YQL NOTICE: TraceId: 01k8gyg5ncdnjeht6ka452z4xg, SessionId: CompileActor 2025-10-26 19:04:09.813 NOTE  ydbd(pid=1724377, tid=0x00007FAE73AE0640) [common provider] yql_provider_gateway.cpp:21: <main>:3:16: Error: Cannot find table 'db.[]' because it does not exist or you do not have access permissions. Please check correctness of table path and user permissions., code: 2003
2025-10-26T19:04:09.815240Z :KQP_COMPILE_ACTOR ERROR: Compilation failed, self: [1:7565608295754752124:4213], status: SCHEME_ERROR, issues: <main>: Error: Type annotation, code: 1030
    <main>:3:16: Error: At function: KiReadTable!
        <main>:3:16: Error: Cannot find table 'db.[]' because it does not exist or you do not have access permissions. Please check correctness of table path and user permissions., code: 2003
2025-10-26T19:04:09.815500Z :KQP_SESSION WARN: SessionId: ydb://session/3?node_id=1&id=MzFiY2E1MWQtZmIzYWExMWMtNmZlMzg3YWEtZjJkOTRlYTk=, ActorId: [1:7565608295754752122:4212], ActorState: ExecuteState, TraceId: 01k8gyg5ncdnjeht6ka452z4xg, ReplyQueryCompileError, status SCHEME_ERROR remove tx with tx_id: 
2025-10-26T19:04:09.832539Z :PERSQUEUE_CLUSTER_TRACKER ERROR: failed to list clusters: { Response { QueryIssues { message: "Type annotation" issue_code: 1030 severity: 1 issues { position { row: 3 column: 16 } message: "At function: KiReadTable!" end_position { row: 3 column: 16 } severity: 1 issues { position { row: 3 column: 16 } message: "Cannot find table \'db.[]\' because it does not exist or you do not have access permissions. Please check correctness of table path and user permissions." end_position { row: 3 column: 16 } issue_code: 2003 severity: 1 } } } TxMeta { } } YdbStatus: SCHEME_ERROR ConsumedRu: 1 WorkerIsClosing: true }
2025-10-26T19:04:10.834413Z :KQP_PROXY NOTICE: Cannot create session: system shutdown requested.
2025-10-26T19:04:10.836034Z :PERSQUEUE_CLUSTER_TRACKER ERROR: failed to list clusters: { Response { QueryIssues { message: "Cannot create session: system shutdown requested." severity: 1 } } YdbStatus: OVERLOADED }
2025-10-26T19:04:11.837258Z :KQP_PROXY NOTICE: Cannot create session: system shutdown requested.
2025-10-26T19:04:11.837455Z :PERSQUEUE_CLUSTER_TRACKER ERROR: failed to list clusters: { Response { QueryIssues { message: "Cannot create session: system shutdown requested." severity: 1 } } YdbStatus: OVERLOADED }
2025-10-26T19:04:12.837260Z :KQP_PROXY NOTICE: Cannot create session: system shutdown requested.
2025-10-26T19:04:12.837462Z :PERSQUEUE_CLUSTER_TRACKER ERROR: failed to list clusters: { Response { QueryIssues { message: "Cannot create session: system shutdown requested." severity: 1 } } YdbStatus: OVERLOADED }
