2025-12-05T20:38:24.909056Z node 4 :METADATA_PROVIDER WARN: log.cpp:841: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[4:7580475993206501132:2084];send_to=[0:7307199536658146131:7762515];
2025-12-05T20:38:24.909257Z node 4 :METADATA_PROVIDER ERROR: log.cpp:841: fline=accessor_snapshot_base.cpp:71;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=scheme_cache_undelivered_message;
2025-12-05T20:38:24.910937Z node 4 :KQP_PROXY WARN: kqp_finalize_script_service.cpp:135: [ScriptExecutions] [TKqpFinalizeScriptService] Failed to check script execution tables existence, scheme status: LookupError, path: Root/.metadata/script_executions
test_client.cpp: SetPath # /home/runner/.ya/build/build_root/a01k/005ea3/r3tmp/tmpbu8skm/pdisk_1.dat
2025-12-05T20:38:24.923276Z node 4 :IMPORT WARN: schemeshard_import.cpp:423: Table profiles were not loaded
TServer::EnableGrpc on GrpcPort 11147, node 4
2025-12-05T20:38:24.938957Z node 4 :NET_CLASSIFIER WARN: net_classifier.cpp:190: distributable config is empty, broken or outdated, will use file: (empty maybe)
2025-12-05T20:38:24.938969Z node 4 :NET_CLASSIFIER WARN: net_classifier.cpp:196: will try to initialize from file: (empty maybe)
2025-12-05T20:38:24.938970Z node 4 :NET_CLASSIFIER WARN: net_classifier.cpp:204: failed to initialize from file: (empty maybe)
2025-12-05T20:38:24.938988Z node 4 :NET_CLASSIFIER ERROR: net_classifier.cpp:228: got bad distributable configuration
TClient is connected to server localhost:1046
WaitRootIsUp 'Root'...
TClient::Ls request: Root
TClient::Ls response: Status: 1
StatusCode: SUCCESS
SchemeStatus: 0
PathDescription {
  Self {
    Name: "Root"
    PathId: 1
    SchemeshardId: 72057594046644480
    PathType: EPathTypeDir
    CreateFinished: true
    CreateTxId: 1
    CreateStep: 0
    ParentPathId: 1
    PathState: EPathStateNoChanges
    Owner: "root@builtin"
    ACL: ""
    EffectiveACL: ""
    PathVersion: 2
    PathSubType: EPathSubTypeEmpty
    Version {
      GeneralVersion: 2
      ACLVersion: 0
      EffectiveACLVersion: 0
      UserAttrsVersion: 1
      ChildrenVersion: 1
      SubDomainVersion: 0
      SecurityStateVersion: 0
    }
    ChildrenExist: false
  }
  Children {
    Name: ".sys"
    PathId: 18446744073709551615
    SchemeshardId: 72057594046644480
    PathType: EPathTypeDir
    CreateFinished: true
    CreateTxId: 0
    CreateStep: 0
    ParentPathId: 18446744073709551615
  }
  DomainDescription {
    SchemeShardId_Depricated: 72057594046644480
    PathId_Depricated: 1
    ProcessingParams {
      Version: 0
      Pl...
(TRUNCATED)
WaitRootIsUp 'Root' success.
2025-12-05T20:38:25.010953Z node 4 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-12-05T20:38:25.010979Z node 4 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-12-05T20:38:25.012365Z node 4 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-12-05T20:38:25.012531Z node 4 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 281474976715657:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at ydb/core/tx/schemeshard/schemeshard__operation_alter_subdomain.cpp:311)
waiting...
2025-12-05T20:38:25.178498Z node 4 :KQP_PROXY WARN: kqp_finalize_script_service.cpp:135: [ScriptExecutions] [TKqpFinalizeScriptService] Failed to check script execution tables existence, scheme status: PathErrorUnknown, path: Root/.metadata/script_executions
2025-12-05T20:38:25.192354Z node 4 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateColumnTable, opId: 281474976715658:1, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at ydb/core/tx/schemeshard/olap/operations/create_table.cpp:814)
2025-12-05T20:38:25.199609Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];fline=columnshard.cpp:110;event=initialize_shard;step=OnActivateExecutor;
2025-12-05T20:38:25.203405Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];fline=columnshard.cpp:129;event=initialize_shard;step=initialize_tiring_finished;
2025-12-05T20:38:25.203452Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: TxInitSchema.Execute at tablet 72075186224037888
2025-12-05T20:38:25.204024Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:90;event=normalization_start;last_saved_id=0;
2025-12-05T20:38:25.204059Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=Granules;
2025-12-05T20:38:25.204089Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=Chunks;
2025-12-05T20:38:25.204105Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=TablesCleaner;
2025-12-05T20:38:25.204121Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=CleanGranuleId;
2025-12-05T20:38:25.204135Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=GCCountersNormalizer;
2025-12-05T20:38:25.204151Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=SyncPortionFromChunks;
2025-12-05T20:38:25.204166Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=RestoreV1Chunks_V2;
2025-12-05T20:38:25.204181Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=RestoreV2Chunks;
2025-12-05T20:38:25.204219Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=CleanDeprecatedSnapshot;
2025-12-05T20:38:25.204231Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=RestoreV0ChunksMeta;
2025-12-05T20:38:25.204245Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=CopyBlobIdsToV2;
2025-12-05T20:38:25.204259Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=RestoreAppearanceSnapshot;
2025-12-05T20:38:25.205052Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: TxInitSchema.Complete at tablet 72075186224037888
2025-12-05T20:38:25.205075Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: fline=columnshard.cpp:116;event=tiering_new_event;
2025-12-05T20:38:25.205088Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=columnshard__init.cpp:131;step=TTxUpdateSchema.Execute_Start;details=normalizers_count=12;current_normalizer=CLASS_NAME=Granules;
2025-12-05T20:38:25.205091Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:156;event=normalizer_init;last=0;seq_id=1;type=Granules;
2025-12-05T20:38:25.205119Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=normalizer.cpp:127;normalizer=TGranulesNormalizer;message=0 chunks found;
2025-12-05T20:38:25.205140Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:62;event=normalizer_finished;description=CLASS_NAME=Granules;id=1;
2025-12-05T20:38:25.205150Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:42;event=normalizer_switched;description=CLASS_NAME=Chunks;id=Chunks;
2025-12-05T20:38:25.205152Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:156;event=normalizer_init;last=0;seq_id=2;type=Chunks;
2025-12-05T20:38:25.205158Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=chunks.cpp:138;normalizer=TChunksNormalizer;message=0 chunks found;
2025-12-05T20:38:25.205168Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:62;event=normalizer_finished;description=CLASS_NAME=Chunks;id=2;
2025-12-05T20:38:25.205175Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:42;event=normalizer_switched;description=CLASS_NAME=TablesCleaner;id=TablesCleaner;
2025-12-05T20:38:25.205180Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:156;event=normalizer_init;last=0;seq_id=4;type=TablesCleaner;
2025-12-05T20:38:25.205192Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=normalizer.cpp:123;normalizer=TGranulesNormalizer;message=0 chunks found;
2025-12-05T20:38:25.205199Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:62;event=normalizer_finished;description=CLASS_NAME=TablesCleaner;id=4;
2025-12-05T20:38:25.205206Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:42;event=normalizer_switched;description=CLASS_NAME=CleanGranuleId;id=CleanGranuleId;
2025-12-05T20:38:25.205208Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:156;event=normalizer_init;last=0;seq_id=6;type=CleanGranuleId;
2025-12-05T20:38:25.205214Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=clean_granule.cpp:133;normalizer=TCleanGranuleIdNormalizer;message=0 chunks found;
2025-12-05T20:38:25.205222Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:62;event=normalizer_finished;description=CLASS_NAME=CleanGranuleId;id=6;
2025-12-05T20:38:25.205225Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:42;event=normalizer_switched;description=CLASS_NAME=GCCountersNormalizer;id=GCCountersNormalizer;
2025-12-05T20:38:25.205230Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:156;event=normalizer_init;last=0;seq_id=9;type=GCCountersNormalizer;
2025-12-05T20:38:25.205235Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:62;event=normalizer_finished;description=CLASS_NAME=GCCountersNormalizer;id=9;
2025-12-05T20:38:25.205242Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:42;event=normalizer_switched;description=CLASS_NAME=SyncPortionFromChunks;id=SyncPortionFromChunks;
2025-12-05T20:38:25.205243Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:156;event=normalizer_init;last=0;seq_id=11;type=SyncPortionFromChunks;
2025-12-05T20:38:25.205247Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:62;event=normalizer_finished;description=CLASS_NAME=SyncPortionFromChunks;id=11;
2025-12-05T20:38:25.205263Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:42;event=normalizer_switched;description=CLASS_NAME=RestoreV1Chunks_V2;id=RestoreV1Chunks_V2;
2025-12-05T20:38:25.205270Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:156;event=normalizer_init;last=0;seq_id=15;type=RestoreV1Chunks_V2;
2025-12-05T20:38:25.205286Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:62;event=normalizer_finished;description=CLASS_NAME=RestoreV1Chunks_V2;id=15;
2025-12-05T20:38:25.205290Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:42;event=normalizer_switched;description=CLASS_NAME=RestoreV2Chunks;id=RestoreV2Chunks;
2025-12-05T20:38:25.205292Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:156;event=normalizer_init;last=0;seq_id=16;type=RestoreV2Chunks;
2025-12-05T20:38:25.205300Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:62;event=normalizer_finished;description=CLASS_NAME=RestoreV2Chunks;id=16;
2025-12-05T20:38:25.205304Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:42;event=normalizer_switched;description=CLASS_NAME=CleanDeprecatedSnapshot;id=CleanDeprecatedSnapshot;
2025-12-05T20:38:25.205309Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:156;event=normalizer_init;last=0;seq_id=17;type=CleanDeprecatedSnapshot;
2025-12-05T20:38:25.205312Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:62;event=normalizer_finished;description=CLASS_NAME=CleanDeprecatedSnapshot;id=17;
2025-12-05T20:38:25.205315Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:42;event=normalizer_switched;description=CLASS_NAME=RestoreV0ChunksMeta;id=RestoreV0ChunksMeta;
2025-12-05T20:38:25.205317Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:156;event=normalizer_init;last=0;seq_id=18;type=RestoreV0ChunksMeta;
2025-12-05T20:38:25.205320Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:62;event=normalizer_finished;description=CLASS_NAME=RestoreV0ChunksMeta;id=18;
2025-12-05T20:38:25.205324Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:42;event=normalizer_switched;description=CLASS_NAME=CopyBlobIdsToV2;id=CopyBlobIdsToV2;
2025-12-05T20:38:25.205327Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:156;event=normalizer_init;last=0;seq_id=19;type=CopyBlobIdsToV2;
2025-12-05T20:38:25.205335Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:62;event=normalizer_finished;description=CLASS_NAME=CopyBlobIdsToV2;id=19;
2025-12-05T20:38:25.205341Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:42;event=normalizer_switched;description=CLASS_NAME=RestoreAppearanceSnapshot;id=RestoreAppearanceSnapshot;
2025-12-05T20:38:25.205343Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:156;event=normalizer_init;last=0;seq_id=20;type=RestoreAppearanceSnapshot;
2025-12-05T20:38:25.205349Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:62;event=normalizer_finished;description=CLASS_NAME=RestoreAppearanceSnapshot;id=20;
2025-12-05T20:38:25.205352Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:45;event=normalization_finished;
2025-12-05T20:38:25.205354Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=columnshard__init.cpp:151;step=TTxUpdateSchema.Execute_Finish;
2025-12-05T20:38:25.205381Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];process=Enqueue;ev=NKikimr::NColumnShard::TEvPrivate::TEvTieringModified;fline=columnshard.cpp:71;event=skip_switch_to_work;reason=db_reading_not_finished;
2025-12-05T20:38:25.206738Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Complete;fline=columnshard__init.cpp:158;step=TTxUpdateSchema.Complete;
2025-12-05T20:38:25.206760Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: TTxInit.Execute at tablet 72075186224037888
2025-12-05T20:38:25.206806Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;fline=common_data.cpp:29;PRECHARGE:composite_initLoadingTime=2;
2025-12-05T20:38:25.206837Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;PRECHARGE:special_valuesLoadingTime=20;
2025-12-05T20:38:25.206862Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;EXECUTE:special_valuesLoadingTime=17;
2025-12-05T20:38:25.206888Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;PRECHARGE:tables_managerLoadingTime=19;
2025-12-05T20:38:25.206909Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;load_stage_name=EXECUTE:composite_init/tables_manager;fline=common_data.cpp:29;TablesLoadingTime=2;
2025-12-05T20:38:25.206917Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;load_stage_name=EXECUTE:composite_init/tables_manager;fline=common_data.cpp:29;SchemaPresetLoadingTime=2;
2025-12-05T20:38:25.206922Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;load_stage_name=EXECUTE:composite_init/tables_manager;fline=common_data.cpp:29;TableVersionssLoadingTime=3;
2025-12-05T20:38:25.206932Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;load_stage_name=EXECUTE:composite_init/tables_manager;fline=common_data.cpp:29;SchemaPresetVersionsLoadingTime=3;
2025-12-05T20:38:25.206940Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;EXECUTE:tables_managerLoadingTime=46;
2025-12-05T20:38:25.206953Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;PRECHARGE:tx_controllerLoadingTime=5;
2025-12-05T20:38:25.206967Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;EXECUTE:tx_controllerLoadingTime=8;
2025-12-05T20:38:25.206981Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;PRECHARGE:operations_managerLoadingTime=7;
2025-12-05T20:38:25.206993Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;EXECUTE:operations_managerLoadingTime=4;
2025-12-05T20:38:25.207015Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;PRECHARGE:storages_managerLoadingTime=16;
2025-12-05T20:38:25.207058Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;EXECUTE:storages_managerLoadingTime=36;
2025-12-05T20:38:25.207067Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;PRECHARGE:db_locksLoadingTime=1;
2025-12-05T20:38:25.207071Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;EXECUTE:db_locksLoadingTime=1;
2025-12-05T20:38:25.207075Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;PRECHARGE:bg_sessionsLoadingTime=1;
2025-12-05T20:38:25.207089Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;EXECUTE:bg_sessionsLoadingTime=7;
2025-12-05T20:38:25.207093Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;PRECHARGE:sharing_sessionsLoadingTime=0;
2025-12-05T20:38:25.207102Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;EXECUTE:sharing_sessionsLoadingTime=7;
2025-12-05T20:38:25.207110Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;PRECHARGE:in_flight_readsLoadingTime=1;
2025-12-05T20:38:25.207119Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;EXECUTE:in_flight_readsLoadingTime=6;
2025-12-05T20:38:25.207128Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;PRECHARGE:tiers_managerLoadingTime=3;
2025-12-05T20:38:25.207135Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;load_stage_name=EXECUTE:composite_init;fline=common_data.cpp:29;EXECUTE:tiers_managerLoadingTime=4;
2025-12-05T20:38:25.207141Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;fline=common_data.cpp:29;EXECUTE:composite_initLoadingTime=327;
2025-12-05T20:38:25.207161Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];process=SwitchToWork;fline=columnshard.cpp:78;event=initialize_shard;step=SwitchToWork;
2025-12-05T20:38:25.207173Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];process=SwitchToWork;fline=columnshard.cpp:81;event=initialize_shard;step=SignalTabletActive;
2025-12-05T20:38:25.207185Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];process=SwitchToWork;fline=columnshard_impl.cpp:1531;event=OnTieringModified;path_id=NO_VALUE_OPTIONAL;
2025-12-05T20:38:25.207194Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;fline=columnshard_impl.cpp:448;event=EnqueueBackgroundActivities;periodic=0;
2025-12-05T20:38:25.207202Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;fline=columnshard_impl.cpp:454;problem=Background activities cannot be started: no index at tablet;
2025-12-05T20:38:25.207209Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: fline=columnshard.cpp:505;event=TEvReportBaseStatistics;ReportBaseStatisticsPeriodMs=60000;scheduleDuration=60.050000s;
2025-12-05T20:38:25.207237Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NActors::TEvents::TEvWakeup;fline=columnshard.cpp:269;event=TEvPrivate::TEvPeriodicWakeup::MANUAL;tablet_id=72075186224037888;
2025-12-05T20:38:25.207249Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NKikimr::NColumnShard::TEvPrivate::TEvPeriodicWakeup;fline=columnshard.cpp:260;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;
2025-12-05T20:38:25.207256Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NKikimr::NColumnShard::TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;fline=columnshard_impl.cpp:448;event=EnqueueBackgroundActivities;periodic=0;
2025-12-05T20:38:25.207258Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NKikimr::NColumnShard::TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;fline=columnshard_impl.cpp:454;problem=Background activities cannot be started: no index at tablet;
2025-12-05T20:38:25.207270Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NKikimr::NColumnShard::TEvPrivate::TEvReportExecutorStatistics;fline=columnshard.cpp:515;event=TEvReportExecutorStatistics;ReportExecutorStatisticsPeriodMs=60000;scheduleDuration=60.136000s;
2025-12-05T20:38:25.207277Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NKikimr::NColumnShard::TEvPrivate::TEvReportExecutorStatistics;fline=columnshard.cpp:447;No CurrentSchemeShardId=72075186224037888;
2025-12-05T20:38:25.207283Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: Server pipe connected at tablet 72075186224037888
2025-12-05T20:38:25.207368Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NActors::IEventHandle;tablet_id=72075186224037888;tx_id=281474976715658;this=20847155693248;fline=columnshard__propose_transaction.cpp:54;event=propose;subdomain_id=1;
2025-12-05T20:38:25.207377Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NActors::IEventHandle;tablet_id=72075186224037888;tx_id=281474976715658;this=20847155693248;fline=columnshard_subdomain_path_id.cpp:78;started_watching_subdomain=1;
2025-12-05T20:38:25.207479Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NActors::IEventHandle;tablet_id=72075186224037888;tx_id=281474976715658;this=20847155693248;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=1764967105207;max=18446744073709551615;plan=0;src=[4:7580475993206501442:2205];cookie=12:1;;fline=tables_manager.cpp:57;method=resolve_internal_path_id;ss_local=3;result=not_found;
2025-12-05T20:38:25.207487Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NActors::IEventHandle;tablet_id=72075186224037888;tx_id=281474976715658;this=20847155693248;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=1764967105207;max=18446744073709551615;plan=0;src=[4:7580475993206501442:2205];cookie=12:1;;fline=schema.h:38;event=sync_schema;
2025-12-05T20:38:25.207561Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated;fline=columnshard_subdomain_path_id.cpp:90;notify_subdomain=[OwnerId: 72057594046644480, LocalPathId: 1];
2025-12-05T20:38:25.208707Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;request_tx=281474976715658:TX_KIND_SCHEMA;min=1764967105207;max=18446744073709551615;plan=0;src=[4:7580475993206501442:2205];cookie=12:1;;this=20847155693248;op_tx=281474976715658:TX_KIND_SCHEMA;min=1764967105207;max=18446744073709551615;plan=0;src=[4:7580475993206501442:2205];cookie=12:1;;int_op_tx=281474976715658:TX_KIND_SCHEMA;min=1764967105207;max=18446744073709551615;plan=0;src=[4:7580475993206501442:2205];cookie=12:1;;int_this=20847176878592;fline=columnshard__propose_transaction.cpp:105;event=actual tx operator;
2025-12-05T20:38:25.208728Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;request_tx=281474976715658:TX_KIND_SCHEMA;min=1764967105207;max=18446744073709551615;plan=0;src=[4:7580475993206501442:2205];cookie=12:1;;this=20847155693248;op_tx=281474976715658:TX_KIND_SCHEMA;min=1764967105207;max=18446744073709551615;plan=0;src=[4:7580475993206501442:2205];cookie=12:1;;int_op_tx=281474976715658:TX_KIND_SCHEMA;min=1764967105207;max=18446744073709551615;plan=0;src=[4:7580475993206501442:2205];cookie=12:1;;int_this=20847176878592;method=TTxController::FinishProposeOnComplete;tx_id=281474976715658;fline=propose_tx.cpp:32;message=;tablet_id=72075186224037888;tx_id=281474976715658;
2025-12-05T20:38:25.208750Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: Registered with mediator time cast at tablet 72075186224037888
2025-12-05T20:38:25.209781Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: Server pipe connected at tablet 72075186224037888
2025-12-05T20:38:25.209796Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: PlanStep 1764967105258 at tablet 72075186224037888, mediator 72057594046382081
2025-12-05T20:38:25.209805Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: TxPlanStep[2] execute at tablet 72075186224037888
2025-12-05T20:38:25.209859Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;tx_state=TTxProgressTx::Execute;tx_current=0;tx_id=281474976715658;fline=tables_manager.cpp:57;method=resolve_internal_path_id;ss_local=3;result=not_found;
2025-12-05T20:38:25.209873Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;tx_state=TTxProgressTx::Execute;tx_current=0;tx_id=281474976715658;fline=tables_manager.cpp:57;method=resolve_internal_path_id;ss_local=3;result=not_found;
2025-12-05T20:38:25.209878Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;tx_state=TTxProgressTx::Execute;tx_current=0;tx_id=281474976715658;fline=tables_manager.cpp:57;method=resolve_internal_path_id;ss_local=3;result=not_found;
2025-12-05T20:38:25.209890Z node 4 :TX_COLUMNSHARD INFO: ctor_logger.h:56: EnsureTable for pathId: {internal: 1000000889, ss: 3} ttl settings: {  } at tablet 72075186224037888
2025-12-05T20:38:25.209909Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;tx_state=TTxProgressTx::Execute;tx_current=0;tx_id=281474976715658;fline=tables_manager.cpp:367;method=RegisterTable;path_id=1000000889;
2025-12-05T20:38:25.210984Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;tx_state=TTxProgressTx::Execute;tx_current=0;tx_id=281474976715658;fline=column_engine_logs.cpp:83;event=new_schema;snapshot=plan_step=1764967105258;tx_id=281474976715658;;switch_optimizer=0;switch_accessors=0;
2025-12-05T20:38:25.210999Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;tx_state=TTxProgressTx::Execute;tx_current=0;tx_id=281474976715658;fline=column_engine.h:145;event=RegisterTable;path_id=1000000889;
2025-12-05T20:38:25.211049Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;tx_state=TTxProgressTx::Execute;tx_current=0;tx_id=281474976715658;fline=tiling.cpp:809;message=creating tiling compaction optimizer;
2025-12-05T20:38:25.211120Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;tx_state=TTxProgressTx::Execute;tx_current=0;tx_id=281474976715658;fline=column_engine_logs.cpp:533;event=OnTieringModified;new_count_tierings=0;
2025-12-05T20:38:25.211210Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated;fline=columnshard_subdomain_path_id.cpp:90;notify_subdomain=[OwnerId: 72057594046644480, LocalPathId: 1];
2025-12-05T20:38:25.211225Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: TTxNotifyTxCompletion.Execute at tablet 72075186224037888
2025-12-05T20:38:25.211505Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: TxPlanStep[2] complete at tablet 72075186224037888
Table type: 1
FALLBACK_ACTOR_LOGGING;priority=TRACE;component=2100;fline=native.cpp:71;event=parsing;size=3864;columns=7;
FALLBACK_ACTOR_LOGGING;priority=DEBUG;component=2100;fline=native.cpp:110;event=serialize;size=3864;columns=7;
2025-12-05T20:38:25.215153Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: Server pipe connected at tablet 72075186224037888
2025-12-05T20:38:25.216059Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NKikimr::NColumnShard::NPrivateEvents::NWrite::TEvWritePortionResult;tablet_id=72075186224037888;event=TEvWritePortionResult;tablet_id=72075186224037888;local_tx_no=4;method=execute;tx_info=TTxBlobsWritingFinished;tablet_id=72075186224037888;tx_state=execute;fline=constructor_meta.cpp:48;memory_size=60;data_size=12;sum=180;count=5;
2025-12-05T20:38:25.216071Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NKikimr::NColumnShard::NPrivateEvents::NWrite::TEvWritePortionResult;tablet_id=72075186224037888;event=TEvWritePortionResult;tablet_id=72075186224037888;local_tx_no=4;method=execute;tx_info=TTxBlobsWritingFinished;tablet_id=72075186224037888;tx_state=execute;fline=constructor_meta.cpp:66;memory_size=156;data_size=124;sum=468;count=6;size_of_meta=112;
2025-12-05T20:38:25.216076Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NKikimr::NColumnShard::NPrivateEvents::NWrite::TEvWritePortionResult;tablet_id=72075186224037888;event=TEvWritePortionResult;tablet_id=72075186224037888;local_tx_no=4;method=execute;tx_info=TTxBlobsWritingFinished;tablet_id=72075186224037888;tx_state=execute;fline=constructor_portion.cpp:44;memory_size=236;data_size=204;sum=708;count=3;size_of_portion=192;
2025-12-05T20:38:25.216141Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: BlobManager on execute at tablet 72075186224037888 Save Batch GenStep: 1:1 Blob count: 1
2025-12-05T20:38:25.217500Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: BlobManager at tablet 72075186224037888 Save Batch GenStep: 1:1 Blob count: 1
2025-12-05T20:38:25.217596Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;local_tx_no=4;method=complete;tx_info=TTxBlobsWritingFinished;tablet_id=72075186224037888;tx_state=complete;fline=tiling.cpp:710;message=tiling compaction: returning DoGetUsefulMetric zero;
SUCCESS
Upsert done: 0.003586s
2025-12-05T20:38:25.218946Z node 4 :KQP_WORKLOAD_SERVICE WARN: scheme_actors.cpp:225: [WorkloadService] [TPoolFetcherActor] ActorId: [4:7580475997501469561:2343], DatabaseId: /Root, PoolId: default, Failed to fetch pool info, NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-05T20:38:25.218949Z node 4 :KQP_WORKLOAD_SERVICE WARN: scheme_actors.cpp:225: [WorkloadService] [TPoolFetcherActor] ActorId: [4:7580475997501469551:2340], DatabaseId: /Root, PoolId: default, Failed to fetch pool info, NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-05T20:38:25.218961Z node 4 :KQP_WORKLOAD_SERVICE WARN: kqp_workload_service.cpp:263: [WorkloadService] [Service] Failed to fetch pool default, DatabaseId: /Root, status: NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-05T20:38:25.219040Z node 4 :KQP_WORKLOAD_SERVICE WARN: scheme_actors.cpp:225: [WorkloadService] [TPoolFetcherActor] ActorId: [4:7580475997501469566:2345], DatabaseId: /Root, PoolId: default, Failed to fetch pool info, NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-05T20:38:25.219056Z node 4 :KQP_WORKLOAD_SERVICE WARN: kqp_workload_service.cpp:263: [WorkloadService] [Service] Failed to fetch pool default, DatabaseId: /Root, status: NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-05T20:38:25.219607Z node 4 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateResourcePool, opId: 281474976715659:3, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at ydb/core/tx/schemeshard/schemeshard__operation_create_resource_pool.cpp:179)
2025-12-05T20:38:25.220827Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated;fline=columnshard_subdomain_path_id.cpp:90;notify_subdomain=[OwnerId: 72057594046644480, LocalPathId: 1];
2025-12-05T20:38:25.223633Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated;fline=columnshard_subdomain_path_id.cpp:90;notify_subdomain=[OwnerId: 72057594046644480, LocalPathId: 1];
2025-12-05T20:38:25.224168Z node 4 :KQP_WORKLOAD_SERVICE WARN: helpers.h:73: [WorkloadService] [TPoolCreatorActor] ActorId: [4:7580475997501469565:2344], DatabaseId: /Root, PoolId: default, Scheduled retry for error: { <main>: Error: Transaction 281474976715659 completed, doublechecking }
2025-12-05T20:38:25.307273Z node 4 :TX_PROXY ERROR: schemereq.cpp:593: Actor# [4:7580475997501469648:2793] txid# 281474976715660, issues: { message: "Check failed: path: \'/Root/.metadata/workload_manager/pools/default\', error: path exist, request accepts it (id: [OwnerId: 72057594046644480, LocalPathId: 7], type: EPathTypeResourcePool, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_resource_pool.cpp:92" severity: 1 }
2025-12-05T20:38:25.332613Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: EvScan txId: 281474976715662 scanId: 2 version: {1764967105279:max} readable: {1764967105370:max} at tablet 72075186224037888
2025-12-05T20:38:25.332658Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: TTxScan prepare txId: 281474976715662 scanId: 2 at tablet 72075186224037888
2025-12-05T20:38:25.332771Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NKikimr::TEvDataShard::TEvKqpScan;tx_id=281474976715662;scan_id=2;gen=1;table=/Root/OlapStore/OlapTable;snapshot={1764967105279:max};tablet=72075186224037888;timeout=0.000000s;cpu_limits=Disabled;;fline=program.cpp:34;event=parse_program;program=Command {
  Projection {
    Columns {
      Id: 5
    }
    Columns {
      Id: 3
    }
    Columns {
      Id: 4
    }
    Columns {
      Id: 1
    }
    Columns {
      Id: 7
    }
    Columns {
      Id: 2
    }
    Columns {
      Id: 6
    }
  }
}
Kernels: "O\002\020AsScalar\t\211\004\235\213\004\213\000?\000\000\235?\000\000\235?\000\0000BlockAsTuple\000\t\211\002?\006?\000\002\000\013?\000\001\t\211\002?\010?\000\002\000?\016\001\000/"
;
2025-12-05T20:38:25.339185Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NKikimr::TEvDataShard::TEvKqpScan;tx_id=281474976715662;scan_id=2;gen=1;table=/Root/OlapStore/OlapTable;snapshot={1764967105279:max};tablet=72075186224037888;timeout=0.000000s;cpu_limits=Disabled;;fline=program.cpp:103;parse_proto_program=Command {
  Projection {
    Columns {
      Id: 5
    }
    Columns {
      Id: 3
    }
    Columns {
      Id: 4
    }
    Columns {
      Id: 1
    }
    Columns {
      Id: 7
    }
    Columns {
      Id: 2
    }
    Columns {
      Id: 6
    }
  }
}
Kernels: "O\002\020AsScalar\t\211\004\235\213\004\213\000?\000\000\235?\000\000\235?\000\0000BlockAsTuple\000\t\211\002?\006?\000\002\000\013?\000\001\t\211\002?\010?\000\002\000?\016\001\000/"
;
2025-12-05T20:38:25.339461Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7580475997501469424:2326];ev=NKikimr::TEvDataShard::TEvKqpScan;tx_id=281474976715662;scan_id=2;gen=1;table=/Root/OlapStore/OlapTable;snapshot={1764967105279:max};tablet=72075186224037888;timeout=0.000000s;cpu_limits=Disabled;;fline=program.cpp:52;event=program_parsed;result={"edges":[{"owner_id":0,"inputs":[{"from":8},{"from":12},{"from":4},{"from":6},{"from":2},{"from":14},{"from":10}]},{"owner_id":2,"inputs":[{"from":15}]},{"owner_id":4,"inputs":[{"from":15}]},{"owner_id":6,"inputs":[{"from":15}]},{"owner_id":8,"inputs":[{"from":15}]},{"owner_id":10,"inputs":[{"from":15}]},{"owner_id":12,"inputs":[{"from":15}]},{"owner_id":14,"inputs":[{"from":15}]},{"owner_id":15,"inputs":[{"from":16}]},{"owner_id":16,"inputs":[]}],"nodes":{"15":{"p":{"i":"0","p":{"data":[{"name":"stringToString","id":7},{"name":"id","id":1},{"name":"timestamp","id":2},{"name":"dateTimeS","id":3},{"name":"dateTimeU","id":4},{"name":"date","id":5},{"name":"utf8ToString","id":6}]},"o":"7,1,2,3,4,5,6","t":"FetchOriginalData"},"w":14,"id":15},"2":{"p":{"i":"5","p":{"address":{"name":"date","id":5}},"o":"5","t":"AssembleOriginalData"},"w":19,"id":2},"8":{"p":{"i":"1","p":{"address":{"name":"id","id":1}},"o":"1","t":"AssembleOriginalData"},"w":19,"id":8},"0":{"p":{"i":"5,3,4,1,7,2,6","t":"Projection"},"w":133,"id":0},"4":{"p":{"i":"3","p":{"address":{"name":"dateTimeS","id":3}},"o":"3","t":"AssembleOriginalData"},"w":19,"id":4},"16":{"p":{"p":{"data":[{"name":"stringToString","id":7},{"name":"id","id":1},{"name":"timestamp","id":2},{"name":"dateTimeS","id":3},{"name":"dateTimeU","id":4},{"name":"date","id":5},{"name":"utf8ToString","id":6}]},"o":"0","t":"ReserveMemory"},"w":0,"id":16},"14":{"p":{"i":"6","p":{"address":{"name":"utf8ToString","id":6}},"o":"6","t":"AssembleOriginalData"},"w":19,"id":14},"10":{"p":{"i":"7","p":{"address":{"name":"stringToString","id":7}},"o":"7","t":"AssembleOriginalData"},"w":19,"id":10},"6":{"p":{"i":"4","p":{"address":{"name":"dateTimeU","id":4}},"o":"4","t":"AssembleOriginalData"},"w":19,"id":6},"12":{"p":{"i":"2","p":{"address":{"name":"timestamp","id":2}},"o":"2","t":"AssembleOriginalData"},"w":19,"id":12}}};
2025-12-05T20:38:25.340881Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: external_task_id=;fline=actor.cpp:48;task=agents_waiting=1;additional_info=();;
2025-12-05T20:38:25.341346Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: event_type=NKikimr::NBlobCache::TEvBlobCache::TEvReadBlobRangeResult;fline=task.cpp:110;event=OnDataReady;task=agents_waiting=0;additional_info=();;external_task_id=;
2025-12-05T20:38:25.342326Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: Finished read cookie: 1 at tablet 72075186224037888
2025-12-05T20:38:25.346418Z node 4 :KQP_RESOURCE_MANAGER WARN: kqp_snapshot_manager.cpp:239: KqpSnapshotManager: discarding snapshot; our snapshot: [step: 1764967105279, txId: 18446744073709551615] shutting down
