test_client.cpp: SetPath # /home/runner/.ya/build/build_root/rf5x/0033c2/r3tmp/tmpvMna2B/pdisk_1.dat
2025-11-21T20:41:16.231654Z 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
2025-11-21T20:41:16.231695Z 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=incorrect path status: LookupError;
2025-11-21T20:41:16.246855Z node 4 :IMPORT WARN: schemeshard_import.cpp:307: Table profiles were not loaded
TServer::EnableGrpc on GrpcPort 24492, node 4
2025-11-21T20:41:16.275625Z node 4 :NET_CLASSIFIER WARN: net_classifier.cpp:190: distributable config is empty, broken or outdated, will use file: (empty maybe)
2025-11-21T20:41:16.275640Z node 4 :NET_CLASSIFIER WARN: net_classifier.cpp:196: will try to initialize from file: (empty maybe)
2025-11-21T20:41:16.275642Z node 4 :NET_CLASSIFIER WARN: net_classifier.cpp:204: failed to initialize from file: (empty maybe)
2025-11-21T20:41:16.275689Z node 4 :NET_CLASSIFIER ERROR: net_classifier.cpp:228: got bad distributable configuration
TClient is connected to server localhost:22341
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-11-21T20:41:16.326824Z node 4 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-21T20:41:16.326857Z node 4 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-21T20:41:16.328422Z node 4 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(4, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-11-21T20:41:16.329278Z 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-11-21T20:41:16.524657Z 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-11-21T20:41:16.715663Z 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-11-21T20:41:16.725272Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];fline=columnshard.cpp:110;event=initialize_shard;step=OnActivateExecutor;
2025-11-21T20:41:16.731618Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];fline=columnshard.cpp:129;event=initialize_shard;step=initialize_tiring_finished;
2025-11-21T20:41:16.731679Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: TxInitSchema.Execute at tablet 72075186224037888
2025-11-21T20:41:16.732588Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:90;event=normalization_start;last_saved_id=0;
2025-11-21T20:41:16.732637Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=Granules;
2025-11-21T20:41:16.732720Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=Chunks;
2025-11-21T20:41:16.732759Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=TablesCleaner;
2025-11-21T20:41:16.732794Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=CleanGranuleId;
2025-11-21T20:41:16.732829Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=GCCountersNormalizer;
2025-11-21T20:41:16.732860Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=SyncPortionFromChunks;
2025-11-21T20:41:16.732896Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=RestoreV1Chunks_V2;
2025-11-21T20:41:16.732930Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=RestoreV2Chunks;
2025-11-21T20:41:16.732973Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=CleanDeprecatedSnapshot;
2025-11-21T20:41:16.733007Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=RestoreV0ChunksMeta;
2025-11-21T20:41:16.733035Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=CopyBlobIdsToV2;
2025-11-21T20:41:16.733061Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];tablet_id=72075186224037888;process=TTxInitSchema::Execute;fline=abstract.cpp:11;event=normalizer_register;description=CLASS_NAME=RestoreAppearanceSnapshot;
2025-11-21T20:41:16.734087Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: fline=columnshard.cpp:116;event=tiering_new_event;
2025-11-21T20:41:16.734114Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];process=Enqueue;ev=NKikimr::NColumnShard::TEvPrivate::TEvTieringModified;fline=columnshard.cpp:71;event=skip_switch_to_work;reason=db_reading_not_finished;
2025-11-21T20:41:16.734595Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: TxInitSchema.Complete at tablet 72075186224037888
2025-11-21T20:41:16.734621Z 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-11-21T20:41:16.734627Z 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-11-21T20:41:16.734651Z 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-11-21T20:41:16.734674Z 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-11-21T20:41:16.734684Z 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-11-21T20:41:16.734688Z 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-11-21T20:41:16.734699Z 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-11-21T20:41:16.734707Z 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-11-21T20:41:16.734714Z 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-11-21T20:41:16.734717Z 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-11-21T20:41:16.734737Z 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-11-21T20:41:16.734744Z 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-11-21T20:41:16.734751Z 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-11-21T20:41:16.734754Z 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-11-21T20:41:16.734764Z 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-11-21T20:41:16.734772Z 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-11-21T20:41:16.734779Z 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-11-21T20:41:16.734782Z 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-11-21T20:41:16.734797Z 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-11-21T20:41:16.734803Z 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-11-21T20:41:16.734806Z 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-11-21T20:41:16.734813Z 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-11-21T20:41:16.734819Z 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-11-21T20:41:16.734822Z 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-11-21T20:41:16.734854Z 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-11-21T20:41:16.734861Z 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-11-21T20:41:16.734865Z 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-11-21T20:41:16.734880Z 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-11-21T20:41:16.734887Z 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-11-21T20:41:16.734890Z 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-11-21T20:41:16.734897Z 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-11-21T20:41:16.734902Z 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-11-21T20:41:16.734905Z 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-11-21T20:41:16.734912Z 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-11-21T20:41:16.734919Z 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-11-21T20:41:16.734924Z 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-11-21T20:41:16.734939Z 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-11-21T20:41:16.734945Z 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-11-21T20:41:16.734948Z 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-11-21T20:41:16.734960Z 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-11-21T20:41:16.734964Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=abstract.cpp:45;event=normalization_finished;
2025-11-21T20:41:16.734967Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Execute;fline=columnshard__init.cpp:151;step=TTxUpdateSchema.Execute_Finish;
2025-11-21T20:41:16.736163Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;process=TTxUpdateSchema::Complete;fline=columnshard__init.cpp:158;step=TTxUpdateSchema.Complete;
2025-11-21T20:41:16.736183Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: TTxInit.Execute at tablet 72075186224037888
2025-11-21T20:41:16.736235Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;fline=common_data.cpp:29;PRECHARGE:composite_initLoadingTime=3;
2025-11-21T20:41:16.736263Z 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=14;
2025-11-21T20:41:16.736297Z 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=22;
2025-11-21T20:41:16.736332Z 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=25;
2025-11-21T20:41:16.736360Z 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=3;
2025-11-21T20:41:16.736375Z 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=4;
2025-11-21T20:41:16.736382Z 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=4;
2025-11-21T20:41:16.736390Z 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-11-21T20:41:16.736400Z 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=59;
2025-11-21T20:41:16.736411Z 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=7;
2025-11-21T20:41:16.736423Z 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=9;
2025-11-21T20:41:16.736441Z 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=10;
2025-11-21T20:41:16.736456Z 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=6;
2025-11-21T20:41:16.736492Z 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=27;
2025-11-21T20:41:16.736548Z 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=48;
2025-11-21T20:41:16.736558Z 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=2;
2025-11-21T20:41:16.736562Z 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=2;
2025-11-21T20:41:16.736567Z 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-11-21T20:41:16.736580Z 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=9;
2025-11-21T20:41:16.736585Z 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=1;
2025-11-21T20:41:16.736598Z 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=9;
2025-11-21T20:41:16.736607Z 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-11-21T20:41:16.736620Z 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=9;
2025-11-21T20:41:16.736632Z 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=4;
2025-11-21T20:41:16.736643Z 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=3;
2025-11-21T20:41:16.736648Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;event=initialize_shard;fline=common_data.cpp:29;EXECUTE:composite_initLoadingTime=401;
2025-11-21T20:41:16.736668Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];process=SwitchToWork;fline=columnshard.cpp:78;event=initialize_shard;step=SwitchToWork;
2025-11-21T20:41:16.736682Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];process=SwitchToWork;fline=columnshard.cpp:81;event=initialize_shard;step=SignalTabletActive;
2025-11-21T20:41:16.736695Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];process=SwitchToWork;fline=columnshard_impl.cpp:1531;event=OnTieringModified;path_id=NO_VALUE_OPTIONAL;
2025-11-21T20:41:16.736702Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;fline=columnshard_impl.cpp:448;event=EnqueueBackgroundActivities;periodic=0;
2025-11-21T20:41:16.736706Z 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-11-21T20:41:16.736716Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: fline=columnshard.cpp:505;event=TEvReportBaseStatistics;ReportBaseStatisticsPeriodMs=60000;scheduleDuration=60.018000s;
2025-11-21T20:41:16.736746Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NActors::TEvents::TEvWakeup;fline=columnshard.cpp:269;event=TEvPrivate::TEvPeriodicWakeup::MANUAL;tablet_id=72075186224037888;
2025-11-21T20:41:16.736755Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NKikimr::NColumnShard::TEvPrivate::TEvPeriodicWakeup;fline=columnshard.cpp:260;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;
2025-11-21T20:41:16.736759Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NKikimr::NColumnShard::TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;fline=columnshard_impl.cpp:448;event=EnqueueBackgroundActivities;periodic=0;
2025-11-21T20:41:16.736762Z node 4 :TX_COLUMNSHARD NOTICE: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792: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-11-21T20:41:16.736776Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NKikimr::NColumnShard::TEvPrivate::TEvReportExecutorStatistics;fline=columnshard.cpp:515;event=TEvReportExecutorStatistics;ReportExecutorStatisticsPeriodMs=60000;scheduleDuration=60.073000s;
2025-11-21T20:41:16.736779Z node 4 :TX_COLUMNSHARD INFO: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NKikimr::NColumnShard::TEvPrivate::TEvReportExecutorStatistics;fline=columnshard.cpp:447;No CurrentSchemeShardId=72075186224037888;
2025-11-21T20:41:16.736787Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: Server pipe connected at tablet 72075186224037888
2025-11-21T20:41:16.736925Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NActors::IEventHandle;tablet_id=72075186224037888;tx_id=281474976715658;this=21539989467648;fline=columnshard__propose_transaction.cpp:54;event=propose;subdomain_id=1;
2025-11-21T20:41:16.736932Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NActors::IEventHandle;tablet_id=72075186224037888;tx_id=281474976715658;this=21539989467648;fline=columnshard_subdomain_path_id.cpp:78;started_watching_subdomain=1;
2025-11-21T20:41:16.737095Z node 4 :TX_COLUMNSHARD WARN: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NActors::IEventHandle;tablet_id=72075186224037888;tx_id=281474976715658;this=21539989467648;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=1763757676736;max=18446744073709551615;plan=0;src=[4:7575281537476385110:2207];cookie=12:1;;fline=tables_manager.cpp:57;method=resolve_internal_path_id;ss_local=3;result=not_found;
2025-11-21T20:41:16.737106Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NActors::IEventHandle;tablet_id=72075186224037888;tx_id=281474976715658;this=21539989467648;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=1763757676736;max=18446744073709551615;plan=0;src=[4:7575281537476385110:2207];cookie=12:1;;fline=schema.h:38;event=sync_schema;
2025-11-21T20:41:16.737165Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated;fline=columnshard_subdomain_path_id.cpp:90;notify_subdomain=[OwnerId: 72057594046644480, LocalPathId: 1];
2025-11-21T20:41:16.738264Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;request_tx=281474976715658:TX_KIND_SCHEMA;min=1763757676736;max=18446744073709551615;plan=0;src=[4:7575281537476385110:2207];cookie=12:1;;this=21539989467648;op_tx=281474976715658:TX_KIND_SCHEMA;min=1763757676736;max=18446744073709551615;plan=0;src=[4:7575281537476385110:2207];cookie=12:1;;int_op_tx=281474976715658:TX_KIND_SCHEMA;min=1763757676736;max=18446744073709551615;plan=0;src=[4:7575281537476385110:2207];cookie=12:1;;int_this=21539949540096;fline=columnshard__propose_transaction.cpp:105;event=actual tx operator;
2025-11-21T20:41:16.738282Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;request_tx=281474976715658:TX_KIND_SCHEMA;min=1763757676736;max=18446744073709551615;plan=0;src=[4:7575281537476385110:2207];cookie=12:1;;this=21539989467648;op_tx=281474976715658:TX_KIND_SCHEMA;min=1763757676736;max=18446744073709551615;plan=0;src=[4:7575281537476385110:2207];cookie=12:1;;int_op_tx=281474976715658:TX_KIND_SCHEMA;min=1763757676736;max=18446744073709551615;plan=0;src=[4:7575281537476385110:2207];cookie=12:1;;int_this=21539949540096;method=TTxController::FinishProposeOnComplete;tx_id=281474976715658;fline=propose_tx.cpp:32;message=;tablet_id=72075186224037888;tx_id=281474976715658;
2025-11-21T20:41:16.738321Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: Registered with mediator time cast at tablet 72075186224037888
2025-11-21T20:41:16.740078Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: Server pipe connected at tablet 72075186224037888
2025-11-21T20:41:16.740094Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: PlanStep 1763757676786 at tablet 72075186224037888, mediator 72057594046382081
2025-11-21T20:41:16.740105Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: TxPlanStep[2] execute at tablet 72075186224037888
2025-11-21T20:41:16.740180Z 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-11-21T20:41:16.740197Z 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-11-21T20:41:16.740200Z 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-11-21T20:41:16.740217Z node 4 :TX_COLUMNSHARD INFO: ctor_logger.h:56: EnsureTable for pathId: {internal: 1000000889, ss: 3} ttl settings: {  } at tablet 72075186224037888
2025-11-21T20:41:16.740241Z 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-11-21T20:41:16.741477Z 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=1763757676786;tx_id=281474976715658;;switch_optimizer=0;switch_accessors=0;
2025-11-21T20:41:16.741495Z 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-11-21T20:41:16.741559Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;tx_state=TTxProgressTx::Execute;tx_current=0;tx_id=281474976715658;fline=tiling.cpp:780;message=creating tiling compaction optimizer;
2025-11-21T20:41:16.741582Z 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:516;event=OnTieringModified;new_count_tierings=0;
2025-11-21T20:41:16.741682Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated;fline=columnshard_subdomain_path_id.cpp:90;notify_subdomain=[OwnerId: 72057594046644480, LocalPathId: 1];
2025-11-21T20:41:16.741894Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: TTxNotifyTxCompletion.Execute at tablet 72075186224037888
2025-11-21T20:41:16.742078Z 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-11-21T20:41:16.747136Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: Server pipe connected at tablet 72075186224037888
2025-11-21T20:41:16.749667Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792: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-11-21T20:41:16.749692Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792: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:65;memory_size=156;data_size=124;sum=468;count=6;size_of_meta=112;
2025-11-21T20:41:16.749701Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792: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-11-21T20:41:16.749852Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: BlobManager on execute at tablet 72075186224037888 Save Batch GenStep: 1:1 Blob count: 1
2025-11-21T20:41:16.751135Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: BlobManager at tablet 72075186224037888 Save Batch GenStep: 1:1 Blob count: 1
2025-11-21T20:41:16.751237Z 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:681;message=tiling compaction: returning DoGetUsefulMetric zero;
SUCCESS
Upsert done: 0.006170s
2025-11-21T20:41:16.753176Z node 4 :KQP_WORKLOAD_SERVICE WARN: scheme_actors.cpp:225: [WorkloadService] [TPoolFetcherActor] ActorId: [4:7575281537476385917: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-11-21T20:41:16.753185Z node 4 :KQP_WORKLOAD_SERVICE WARN: scheme_actors.cpp:225: [WorkloadService] [TPoolFetcherActor] ActorId: [4:7575281537476385927: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-11-21T20:41:16.753200Z 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-11-21T20:41:16.753290Z node 4 :KQP_WORKLOAD_SERVICE WARN: scheme_actors.cpp:225: [WorkloadService] [TPoolFetcherActor] ActorId: [4:7575281537476385932: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-11-21T20:41:16.753321Z 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-11-21T20:41:16.754059Z 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-11-21T20:41:16.755661Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated;fline=columnshard_subdomain_path_id.cpp:90;notify_subdomain=[OwnerId: 72057594046644480, LocalPathId: 1];
2025-11-21T20:41:16.758364Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated;fline=columnshard_subdomain_path_id.cpp:90;notify_subdomain=[OwnerId: 72057594046644480, LocalPathId: 1];
2025-11-21T20:41:16.759115Z node 4 :KQP_WORKLOAD_SERVICE WARN: helpers.h:73: [WorkloadService] [TPoolCreatorActor] ActorId: [4:7575281537476385931:2344], DatabaseId: /Root, PoolId: default, Scheduled retry for error: { <main>: Error: Transaction 281474976715659 completed, doublechecking }
2025-11-21T20:41:16.836441Z node 4 :TX_PROXY ERROR: schemereq.cpp:593: Actor# [4:7575281537476386004:2778] 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-11-21T20:41:16.862407Z node 4 :KQP_EXECUTER ERROR: kqp_planner.cpp:123: TxId: 281474976715662. Ctx: { TraceId: 01kam2cp6gc1csnab46s2d4v8k, Database: , SessionId: ydb://session/3?node_id=4&id=NWFiODYyMTItY2E2YTEyNWYtM2MxNjU0M2QtOWQzZWNkZDI=, PoolId: default, DatabaseId: /Root}. Database not set, use /Root
2025-11-21T20:41:16.869153Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: EvScan txId: 281474976715662 scanId: 2 version: {1763757676807:max} readable: {1763757676905:max} at tablet 72075186224037888
2025-11-21T20:41:16.869214Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: TTxScan prepare txId: 281474976715662 scanId: 2 at tablet 72075186224037888
2025-11-21T20:41:16.869331Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NKikimr::TEvDataShard::TEvKqpScan;tx_id=281474976715662;scan_id=2;gen=1;table=/Root/OlapStore/OlapTable;snapshot={1763757676807: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-11-21T20:41:16.875463Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NKikimr::TEvDataShard::TEvKqpScan;tx_id=281474976715662;scan_id=2;gen=1;table=/Root/OlapStore/OlapTable;snapshot={1763757676807: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-11-21T20:41:16.875718Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: tablet_id=72075186224037888;self_id=[4:7575281537476385792:2326];ev=NKikimr::TEvDataShard::TEvKqpScan;tx_id=281474976715662;scan_id=2;gen=1;table=/Root/OlapStore/OlapTable;snapshot={1763757676807: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-11-21T20:41:16.877143Z node 4 :TX_COLUMNSHARD DEBUG: log.cpp:841: external_task_id=;fline=actor.cpp:48;task=agents_waiting=1;additional_info=();;
2025-11-21T20:41:16.877522Z 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-11-21T20:41:16.878109Z node 4 :TX_COLUMNSHARD DEBUG: ctor_logger.h:56: Finished read cookie: 1 at tablet 72075186224037888
2025-11-21T20:41:16.882747Z node 4 :KQP_RESOURCE_MANAGER WARN: kqp_snapshot_manager.cpp:239: KqpSnapshotManager: discarding snapshot; our snapshot: [step: 1763757676807, txId: 18446744073709551615] shutting down
