Trying to start YDB, gRPC: 18987, MsgBus: 23610
2024-06-27T20:55:42.190674Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction
2024-06-27T20:55:42.193273Z node 1 :METADATA_PROVIDER WARN: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[1:7385289648137707175:4098];send_to=[0:7307199536658146131:7762515];
2024-06-27T20:55:42.193360Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction
2024-06-27T20:55:42.194123Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction
2024-06-27T20:55:42.194928Z node 1 :METADATA_PROVIDER ERROR: fline=accessor_snapshot_base.cpp:68;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=scheme_cache_undelivered_message;
test_client.cpp: SetPath # /home/runner/.ya/build/build_root/tyee/00221e/r3tmp/tmpVgGGnc/pdisk_1.dat
2024-06-27T20:55:42.499242Z node 1 :IMPORT WARN: Table profiles were not loaded
TServer::EnableGrpc on GrpcPort 18987, node 1
2024-06-27T20:55:42.547087Z node 1 :HIVE WARN: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2024-06-27T20:55:42.547360Z node 1 :HIVE WARN: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2024-06-27T20:55:42.561810Z node 1 :HIVE WARN: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Connecting -> Connected
2024-06-27T20:55:42.566490Z node 1 :NET_CLASSIFIER WARN: distributable config is empty, broken or outdated, will use file: (empty maybe)
2024-06-27T20:55:42.566519Z node 1 :NET_CLASSIFIER WARN: will try to initialize from file: (empty maybe)
2024-06-27T20:55:42.566527Z node 1 :NET_CLASSIFIER WARN: failed to initialize from file: (empty maybe)
2024-06-27T20:55:42.566609Z node 1 :NET_CLASSIFIER ERROR: got bad distributable configuration
TClient is connected to server localhost:23610
TClient is connected to server localhost:23610
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
    }
  }
  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
      PlanResolution: 7
      Coo...
(TRUNCATED)
WaitRootIsUp 'Root' success.
waiting...
Status: 53
TxId: 281474976715658
SchemeShardStatus: 1
SchemeShardTabletId: 72057594046644480
PathId: 2
2024-06-27T20:55:42.933591Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard.cpp:68;event=initialize_shard;step=OnActivateExecutor;
2024-06-27T20:55:42.933928Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard.cpp:68;event=initialize_shard;step=OnActivateExecutor;
2024-06-27T20:55:42.948207Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard.cpp:84;event=initialize_shard;step=initialize_tiring_finished;
2024-06-27T20:55:42.948317Z node 1 :TX_COLUMNSHARD DEBUG: TxInitSchema.Execute at tablet 72075186224037888
2024-06-27T20:55:42.952396Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard.cpp:84;event=initialize_shard;step=initialize_tiring_finished;
2024-06-27T20:55:42.952509Z node 1 :TX_COLUMNSHARD DEBUG: TxInitSchema.Execute at tablet 72075186224037889
2024-06-27T20:55:42.959688Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:42.959739Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:42.976836Z node 1 :TX_COLUMNSHARD DEBUG: TxInitSchema.Complete at tablet 72075186224037888
2024-06-27T20:55:42.976966Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:274;step=TTxUpdateSchema.Execute_Start;details=normalizers_count=6;current_normalizer=CLASS_NAME=Granules;
2024-06-27T20:55:42.977008Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;event=initialize_shard;fline=abstract.cpp:137;event=normalization_init;last=0;seq_id=1;type=Granules;
2024-06-27T20:55:42.977215Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=normalizer.cpp:127;normalizer=TGranulesNormalizer;message=0 chunks found;
2024-06-27T20:55:42.977354Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;event=initialize_shard;fline=abstract.cpp:137;event=normalization_init;last=0;seq_id=2;type=Chunks;
2024-06-27T20:55:42.977436Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=chunks.cpp:132;normalizer=TChunksNormalizer;message=0 chunks found;
2024-06-27T20:55:42.977535Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;event=initialize_shard;fline=abstract.cpp:137;event=normalization_init;last=0;seq_id=3;type=PortionsCleaner;
2024-06-27T20:55:42.977937Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;event=initialize_shard;fline=abstract.cpp:137;event=normalization_init;last=0;seq_id=4;type=TablesCleaner;
2024-06-27T20:55:42.978120Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=normalizer.cpp:123;normalizer=TGranulesNormalizer;message=0 chunks found;
2024-06-27T20:55:42.978193Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;event=initialize_shard;fline=abstract.cpp:137;event=normalization_init;last=0;seq_id=5;type=PortionsMetadata;
2024-06-27T20:55:42.978509Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;event=initialize_shard;fline=abstract.cpp:137;event=normalization_init;last=0;seq_id=6;type=CleanGranuleId;
2024-06-27T20:55:42.978706Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=clean_granule.cpp:133;normalizer=TCleanGranuleIdNormalizer;message=0 chunks found;
2024-06-27T20:55:42.978793Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:294;step=TTxUpdateSchema.Execute_Finish;
2024-06-27T20:55:42.979410Z node 1 :TX_COLUMNSHARD DEBUG: TxInitSchema.Complete at tablet 72075186224037889
2024-06-27T20:55:42.979505Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:274;step=TTxUpdateSchema.Execute_Start;details=normalizers_count=6;current_normalizer=CLASS_NAME=Granules;
2024-06-27T20:55:42.979538Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;event=initialize_shard;fline=abstract.cpp:137;event=normalization_init;last=0;seq_id=1;type=Granules;
2024-06-27T20:55:42.979560Z node 1 :TX_COLUMNSHARD DEBUG: fline=columnshard.cpp:75;event=tiering_new_event;
2024-06-27T20:55:42.979653Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=normalizer.cpp:127;normalizer=TGranulesNormalizer;message=0 chunks found;
2024-06-27T20:55:42.979788Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;event=initialize_shard;fline=abstract.cpp:137;event=normalization_init;last=0;seq_id=2;type=Chunks;
2024-06-27T20:55:42.979789Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard_impl.cpp:1123;event=OnTieringModified;path_id=NO_VALUE_OPTIONAL;
2024-06-27T20:55:42.979879Z node 1 :TX_COLUMNSHARD INFO: fline=columnshard__init.cpp:299;step=TTxUpdateSchema.Complete;
2024-06-27T20:55:42.979885Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=chunks.cpp:132;normalizer=TChunksNormalizer;message=0 chunks found;
2024-06-27T20:55:42.979943Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;event=initialize_shard;fline=abstract.cpp:137;event=normalization_init;last=0;seq_id=3;type=PortionsCleaner;
2024-06-27T20:55:42.979954Z node 1 :TX_COLUMNSHARD DEBUG: TTxInit.Execute at tablet 72075186224037888
2024-06-27T20:55:42.980189Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;event=initialize_shard;fline=abstract.cpp:137;event=normalization_init;last=0;seq_id=4;type=TablesCleaner;
2024-06-27T20:55:42.980404Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=normalizer.cpp:123;normalizer=TGranulesNormalizer;message=0 chunks found;
2024-06-27T20:55:42.980496Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;event=initialize_shard;fline=abstract.cpp:137;event=normalization_init;last=0;seq_id=5;type=PortionsMetadata;
2024-06-27T20:55:42.980699Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:104;step=TInsertTable::Load_Start;
2024-06-27T20:55:42.980812Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;event=initialize_shard;fline=abstract.cpp:137;event=normalization_init;last=0;seq_id=6;type=CleanGranuleId;
2024-06-27T20:55:42.980887Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=clean_granule.cpp:133;normalizer=TCleanGranuleIdNormalizer;message=0 chunks found;
2024-06-27T20:55:42.980938Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:294;step=TTxUpdateSchema.Execute_Finish;
2024-06-27T20:55:42.981029Z node 1 :TX_COLUMNSHARD DEBUG: fline=columnshard.cpp:75;event=tiering_new_event;
2024-06-27T20:55:42.981087Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard_impl.cpp:1123;event=OnTieringModified;path_id=NO_VALUE_OPTIONAL;
2024-06-27T20:55:42.981809Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:111;step=TInsertTable::Load_Finish;
2024-06-27T20:55:42.981866Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:116;step=TTxController::Load_Start;
2024-06-27T20:55:42.981870Z node 1 :TX_COLUMNSHARD INFO: fline=columnshard__init.cpp:299;step=TTxUpdateSchema.Complete;
2024-06-27T20:55:42.981911Z node 1 :TX_COLUMNSHARD DEBUG: TTxInit.Execute at tablet 72075186224037889
2024-06-27T20:55:42.981939Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:123;step=TTxController::Load_Finish;
2024-06-27T20:55:42.981979Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:128;step=TOperationsManager::Load_Start;
2024-06-27T20:55:42.982080Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:135;step=TOperationsManager::Load_Finish;
2024-06-27T20:55:42.982121Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:140;step=TStoragesManager::Load_Start;
2024-06-27T20:55:42.982494Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:104;step=TInsertTable::Load_Start;
2024-06-27T20:55:42.982507Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=0;
2024-06-27T20:55:42.982569Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:146;step=TStoragesManager::Load_Finish;
2024-06-27T20:55:42.982615Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:150;step=TTablesManager::Load_Start;
2024-06-27T20:55:42.982850Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:171;step=TTablesManager::Load_Finish;
2024-06-27T20:55:42.983111Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 0 in 0 records at tablet 72075186224037888
2024-06-27T20:55:42.983189Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:111;step=TInsertTable::Load_Finish;
2024-06-27T20:55:42.983216Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard.cpp:47;event=initialize_shard;step=SwitchToWork;
2024-06-27T20:55:42.983221Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:116;step=TTxController::Load_Start;
2024-06-27T20:55:42.983261Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:123;step=TTxController::Load_Finish;
2024-06-27T20:55:42.983275Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard.cpp:55;event=initialize_shard;step=SignalTabletActive;
2024-06-27T20:55:42.983276Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:128;step=TOperationsManager::Load_Start;
2024-06-27T20:55:42.983309Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037888;
2024-06-27T20:55:42.983329Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:135;step=TOperationsManager::Load_Finish;
2024-06-27T20:55:42.983342Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:140;step=TStoragesManager::Load_Start;
2024-06-27T20:55:42.983634Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=0;
2024-06-27T20:55:42.983663Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:146;step=TStoragesManager::Load_Finish;
2024-06-27T20:55:42.983681Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:150;step=TTablesManager::Load_Start;
2024-06-27T20:55:42.983686Z node 1 :TX_COLUMNSHARD DEBUG: fline=column_engine.cpp:22;total=202798006272;kff=0.3;
2024-06-27T20:55:42.983881Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:171;step=TTablesManager::Load_Finish;
2024-06-27T20:55:42.983916Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=0;
2024-06-27T20:55:42.983944Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:42.983961Z node 1 :TX_COLUMNSHARD DEBUG: Disabled periodic stats at tablet 72075186224037888
2024-06-27T20:55:42.983971Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 0 in 0 records at tablet 72075186224037889
2024-06-27T20:55:42.984015Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard.cpp:47;event=initialize_shard;step=SwitchToWork;
2024-06-27T20:55:42.984024Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;fline=columnshard_impl.cpp:516;problem=Background activities cannot be started: no index at tablet;
2024-06-27T20:55:42.984033Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard.cpp:55;event=initialize_shard;step=SignalTabletActive;
2024-06-27T20:55:42.984075Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037889;
2024-06-27T20:55:42.984190Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:42.984286Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037888
2024-06-27T20:55:42.984358Z node 1 :TX_COLUMNSHARD DEBUG: fline=column_engine.cpp:22;total=202798006272;kff=0.3;
2024-06-27T20:55:42.984576Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=0;
2024-06-27T20:55:42.984592Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:42.984602Z node 1 :TX_COLUMNSHARD DEBUG: Disabled periodic stats at tablet 72075186224037889
2024-06-27T20:55:42.984615Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;fline=columnshard_impl.cpp:516;problem=Background activities cannot be started: no index at tablet;
2024-06-27T20:55:42.984700Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:42.984768Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037889
2024-06-27T20:55:42.988454Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;tx_id=281474976715658;this=106515189775264;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:1;;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:1;;fline=tx_controller.cpp:292;event=start;
2024-06-27T20:55:42.988469Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;tx_id=281474976715658;this=106515189753088;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:1;;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:1;;fline=tx_controller.cpp:292;event=start;
2024-06-27T20:55:42.988522Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;tx_id=281474976715658;this=106515189753088;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:1;;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:1;;fline=schema.h:35;event=sync_schema;
2024-06-27T20:55:42.988545Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;tx_id=281474976715658;this=106515189775264;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:1;;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:1;;fline=schema.h:35;event=sync_schema;
2024-06-27T20:55:42.988652Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;tx_id=281474976715658;this=106515189753088;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:1;;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:1;;fline=tx_controller.cpp:319;event=registered;
2024-06-27T20:55:42.988682Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;tx_id=281474976715658;this=106515189775264;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:1;;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:1;;fline=tx_controller.cpp:319;event=registered;
2024-06-27T20:55:42.988731Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037889;
2024-06-27T20:55:42.988758Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:42.988768Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;
2024-06-27T20:55:42.988769Z node 1 :TX_COLUMNSHARD DEBUG: Disabled periodic stats at tablet 72075186224037889
2024-06-27T20:55:42.988774Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:42.988787Z node 1 :TX_COLUMNSHARD DEBUG: Disabled periodic stats at tablet 72075186224037888
2024-06-27T20:55:42.989747Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;request_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:1;;this=106515189753088;op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:1;;int_op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:1;;fline=columnshard__propose_transaction.cpp:94;event=actual tx operator;
2024-06-27T20:55:42.989748Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;request_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:1;;this=106515189775264;op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:1;;int_op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:1;;fline=columnshard__propose_transaction.cpp:94;event=actual tx operator;
2024-06-27T20:55:42.989833Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;request_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:1;;this=106515189775264;op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:1;;int_op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:1;;method=TTxController::FinishProposeOnComplete;tx_id=281474976715658;fline=tx_controller.cpp:357;event=start;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:1;;
2024-06-27T20:55:42.989833Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;request_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:1;;this=106515189753088;op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:1;;int_op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:1;;method=TTxController::FinishProposeOnComplete;tx_id=281474976715658;fline=tx_controller.cpp:357;event=start;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:1;;
2024-06-27T20:55:42.990575Z node 1 :TX_COLUMNSHARD DEBUG: Registered with mediator time cast at tablet 72075186224037889
2024-06-27T20:55:42.990602Z node 1 :TX_COLUMNSHARD DEBUG: Registered with mediator time cast at tablet 72075186224037888
2024-06-27T20:55:42.992751Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037889
2024-06-27T20:55:42.992757Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037888
2024-06-27T20:55:42.992791Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719521743037 at tablet 72075186224037888, mediator 72057594046382081
2024-06-27T20:55:42.992792Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719521743037 at tablet 72075186224037889, mediator 72057594046382081
2024-06-27T20:55:42.992841Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[2] execute at tablet 72075186224037888
2024-06-27T20:55:42.992841Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[2] execute at tablet 72075186224037889
2024-06-27T20:55:42.992927Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037889;
2024-06-27T20:55:42.992928Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037888;
2024-06-27T20:55:42.995368Z node 1 :TX_COLUMNSHARD DEBUG: TTxNotifyTxCompletion.Execute at tablet 72075186224037889
2024-06-27T20:55:42.995544Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[2] complete at tablet 72075186224037889
2024-06-27T20:55:42.995597Z node 1 :TX_COLUMNSHARD DEBUG: TTxNotifyTxCompletion.Execute at tablet 72075186224037888
2024-06-27T20:55:42.995634Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:42.995660Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[2] complete at tablet 72075186224037888
2024-06-27T20:55:42.995724Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
Status: 53
TxId: 281474976715659
SchemeShardStatus: 1
SchemeShardTabletId: 72057594046644480
PathId: 3
2024-06-27T20:55:43.003491Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;tx_id=281474976715659;this=106515189753760;method=TTxController::StartProposeOnExecute;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:2;;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:2;;fline=tx_controller.cpp:292;event=start;
2024-06-27T20:55:43.003563Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;tx_id=281474976715659;this=106515189775936;method=TTxController::StartProposeOnExecute;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:2;;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:2;;fline=tx_controller.cpp:292;event=start;
2024-06-27T20:55:43.003606Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;tx_id=281474976715659;this=106515189753760;method=TTxController::StartProposeOnExecute;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:2;;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:2;;fline=schema.h:35;event=sync_schema;
2024-06-27T20:55:43.003654Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;tx_id=281474976715659;this=106515189753760;method=TTxController::StartProposeOnExecute;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:2;;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:2;;fline=tx_controller.cpp:319;event=registered;
2024-06-27T20:55:43.003663Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;tx_id=281474976715659;this=106515189775936;method=TTxController::StartProposeOnExecute;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:2;;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:2;;fline=schema.h:35;event=sync_schema;
2024-06-27T20:55:43.003705Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;tx_id=281474976715659;this=106515189775936;method=TTxController::StartProposeOnExecute;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:2;;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:2;;fline=tx_controller.cpp:319;event=registered;
2024-06-27T20:55:43.005021Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;request_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:2;;this=106515189753760;op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:2;;int_op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:2;;fline=columnshard__propose_transaction.cpp:94;event=actual tx operator;
2024-06-27T20:55:43.005039Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;request_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:2;;this=106515189775936;op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:2;;int_op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:2;;fline=columnshard__propose_transaction.cpp:94;event=actual tx operator;
2024-06-27T20:55:43.005063Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;request_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:2;;this=106515189753760;op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:2;;int_op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:2;;method=TTxController::FinishProposeOnComplete;tx_id=281474976715659;fline=tx_controller.cpp:357;event=start;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=12:2;;
2024-06-27T20:55:43.005099Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;request_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:2;;this=106515189775936;op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:2;;int_op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:2;;method=TTxController::FinishProposeOnComplete;tx_id=281474976715659;fline=tx_controller.cpp:357;event=start;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385289648137707464:12333];cookie=22:2;;
2024-06-27T20:55:43.006803Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719521743051 at tablet 72075186224037888, mediator 72057594046382081
2024-06-27T20:55:43.006826Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[4] execute at tablet 72075186224037888
2024-06-27T20:55:43.006844Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719521743051 at tablet 72075186224037889, mediator 72057594046382081
2024-06-27T20:55:43.006876Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[4] execute at tablet 72075186224037889
2024-06-27T20:55:43.006880Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037888;
2024-06-27T20:55:43.006937Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037889;
2024-06-27T20:55:43.006989Z node 1 :TX_COLUMNSHARD DEBUG: EnsureTable for pathId: 3 ttl settings: {  } at tablet 72075186224037888
2024-06-27T20:55:43.007084Z node 1 :TX_COLUMNSHARD DEBUG: EnsureTable for pathId: 3 ttl settings: {  } at tablet 72075186224037889
2024-06-27T20:55:43.011079Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=execute;fline=column_engine_logs.cpp:543;event=OnTieringModified;new_count_tierings=0;new_count_ttls=0;
2024-06-27T20:55:43.011154Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=execute;fline=tables_manager.cpp:257;method=RegisterTable;path_id=3;
2024-06-27T20:55:43.011175Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=execute;fline=column_engine.h:282;event=RegisterTable;path_id=3;
2024-06-27T20:55:43.011770Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=execute;fline=column_engine_logs.cpp:543;event=OnTieringModified;new_count_tierings=0;new_count_ttls=0;
2024-06-27T20:55:43.011862Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=execute;fline=tables_manager.cpp:257;method=RegisterTable;path_id=3;
2024-06-27T20:55:43.011886Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=execute;fline=column_engine.h:282;event=RegisterTable;path_id=3;
2024-06-27T20:55:43.014890Z node 1 :TX_COLUMNSHARD DEBUG: TTxNotifyTxCompletion.Execute at tablet 72075186224037888
2024-06-27T20:55:43.015113Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[4] complete at tablet 72075186224037888
2024-06-27T20:55:43.015195Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:43.015345Z node 1 :TX_COLUMNSHARD DEBUG: TTxNotifyTxCompletion.Execute at tablet 72075186224037889
2024-06-27T20:55:43.015771Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[4] complete at tablet 72075186224037889
2024-06-27T20:55:43.015810Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
FALLBACK_ACTOR_LOGGING;priority=DEBUG;component=2100;fline=native.cpp:101;event=serialize;size=640144;columns=1;
2024-06-27T20:55:43.041632Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037889
2024-06-27T20:55:43.041633Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037888
2024-06-27T20:55:43.041962Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=column_engine.cpp:22;total=202798006272;kff=0.3;
2024-06-27T20:55:43.042108Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=column_engine.cpp:22;total=202798006272;kff=0.3;
2024-06-27T20:55:43.042239Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=column_engine.cpp:22;total=202798006272;kff=0.3;
2024-06-27T20:55:43.042371Z node 1 :TX_COLUMNSHARD DEBUG: Write (blob) 319568 bytes into pathId 3 {object=write_monitor;count=1;size=319568} at tablet 72075186224037889
2024-06-27T20:55:43.042490Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=column_engine.cpp:22;total=202798006272;kff=0.3;
2024-06-27T20:55:43.042683Z node 1 :TX_COLUMNSHARD DEBUG: Write (blob) 320720 bytes into pathId 3 {object=write_monitor;count=1;size=320720} at tablet 72075186224037888
2024-06-27T20:55:43.675812Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:43.819858Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:43.971899Z node 1 :TX_COLUMNSHARD DEBUG: Finished read cookie: 1 at tablet 72075186224037889
2024-06-27T20:55:44.031380Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;fline=actor.cpp:24;event=restore_task_finished;reason=;
2024-06-27T20:55:44.032763Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;
2024-06-27T20:55:44.032792Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:44.032803Z node 1 :TX_COLUMNSHARD DEBUG: Create periodic stats pipe to 72057594046644480 at tablet 72075186224037888
2024-06-27T20:55:44.032849Z node 1 :TX_COLUMNSHARD DEBUG: There are stats for 0 tables
2024-06-27T20:55:44.032890Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521744000 at tablet 72075186224037888
2024-06-27T20:55:44.032918Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:55:44.032931Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:44.032987Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:44.033047Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:55:44.033065Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:55:44.033090Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888
2024-06-27T20:55:44.033105Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888
2024-06-27T20:55:44.033127Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:55:44.033195Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:55:44.033218Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:44.033260Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:44.033312Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:55:44.033379Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:55:44.033734Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=actor.cpp:22;event=flush_writing;size=319568;count=1;
2024-06-27T20:55:44.038192Z node 1 :TX_COLUMNSHARD DEBUG: Finished read cookie: 1 at tablet 72075186224037888
2024-06-27T20:55:44.150811Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;fline=actor.cpp:24;event=restore_task_finished;reason=;
2024-06-27T20:55:44.151771Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=actor.cpp:22;event=flush_writing;size=320720;count=1;
2024-06-27T20:55:44.152354Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037889;
2024-06-27T20:55:44.152371Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:44.152379Z node 1 :TX_COLUMNSHARD DEBUG: Create periodic stats pipe to 72057594046644480 at tablet 72075186224037889
2024-06-27T20:55:44.152422Z node 1 :TX_COLUMNSHARD DEBUG: There are stats for 0 tables
2024-06-27T20:55:44.152537Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521744000 at tablet 72075186224037889
2024-06-27T20:55:44.152581Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:55:44.152598Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:44.152621Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:44.152658Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:55:44.152672Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:55:44.152679Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889
2024-06-27T20:55:44.152686Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889
2024-06-27T20:55:44.152701Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:55:44.152720Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:55:44.152735Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:44.152747Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:44.152779Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:55:44.152815Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:55:44.153235Z node 1 :TX_COLUMNSHARD DEBUG: Write (record) into pathId 3 at tablet 72075186224037889
2024-06-27T20:55:44.153878Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 644032 in 1 records, committed: 0 in 0 records at tablet 72075186224037889
2024-06-27T20:55:44.153919Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager on execute at tablet 72075186224037889 Save Batch GenStep: 1:1 Blob count: 1
2024-06-27T20:55:44.154462Z node 1 :TX_COLUMNSHARD DEBUG: Connected to 72057594046644480 at tablet 72075186224037889
2024-06-27T20:55:44.154603Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037889 Save Batch GenStep: 1:1 Blob count: 1
2024-06-27T20:55:44.154636Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=1;
2024-06-27T20:55:44.162510Z node 1 :TX_COLUMNSHARD DEBUG: Write (record) into pathId 3 at tablet 72075186224037888
2024-06-27T20:55:44.162844Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 646360 in 1 records, committed: 0 in 0 records at tablet 72075186224037888
2024-06-27T20:55:44.162871Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager on execute at tablet 72075186224037888 Save Batch GenStep: 1:1 Blob count: 1
2024-06-27T20:55:44.162970Z node 1 :TX_COLUMNSHARD DEBUG: Connected to 72057594046644480 at tablet 72075186224037888
2024-06-27T20:55:44.164084Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037888 Save Batch GenStep: 1:1 Blob count: 1
2024-06-27T20:55:44.164113Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=1;
2024-06-27T20:55:44.164589Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;tx_id=281474976715660;this=106515194355616;method=TTxController::StartProposeOnExecute;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;fline=tx_controller.cpp:292;event=start;
2024-06-27T20:55:44.164589Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;tx_id=281474976715660;this=106515190549856;method=TTxController::StartProposeOnExecute;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;fline=tx_controller.cpp:292;event=start;
2024-06-27T20:55:44.164641Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;tx_id=281474976715660;this=106515194355616;method=TTxController::StartProposeOnExecute;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;fline=tx_controller.cpp:319;event=registered;
2024-06-27T20:55:44.164641Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;tx_id=281474976715660;this=106515190549856;method=TTxController::StartProposeOnExecute;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;fline=tx_controller.cpp:319;event=registered;
2024-06-27T20:55:44.165620Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;request_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;this=106515194355616;op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;int_op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;fline=columnshard__propose_transaction.cpp:94;event=actual tx operator;
2024-06-27T20:55:44.165641Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;request_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;this=106515190549856;op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;int_op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;fline=columnshard__propose_transaction.cpp:94;event=actual tx operator;
2024-06-27T20:55:44.165660Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;request_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;this=106515194355616;op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;int_op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;method=TTxController::FinishProposeOnComplete;tx_id=281474976715660;fline=tx_controller.cpp:357;event=start;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;
2024-06-27T20:55:44.165666Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;request_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;this=106515190549856;op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;int_op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;method=TTxController::FinishProposeOnComplete;tx_id=281474976715660;fline=tx_controller.cpp:357;event=start;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385289656727642642:8386];cookie=0;
2024-06-27T20:55:44.166443Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719521744213 at tablet 72075186224037888, mediator 72057594046382081
2024-06-27T20:55:44.166467Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719521744213 at tablet 72075186224037889, mediator 72057594046382081
2024-06-27T20:55:44.166478Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[7] execute at tablet 72075186224037888
2024-06-27T20:55:44.166494Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[7] execute at tablet 72075186224037889
2024-06-27T20:55:44.166537Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037888;
2024-06-27T20:55:44.166553Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037889;
2024-06-27T20:55:44.166710Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 646360 in 1 records at tablet 72075186224037888
2024-06-27T20:55:44.166721Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 644032 in 1 records at tablet 72075186224037889
2024-06-27T20:55:44.167605Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[7] complete at tablet 72075186224037888
2024-06-27T20:55:44.167668Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[7] complete at tablet 72075186224037889
2024-06-27T20:55:44.167677Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=646360;
2024-06-27T20:55:44.167732Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=644032;
2024-06-27T20:55:44.167734Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;fline=manager.cpp:9;event=lock;process_id=CS::INDEXATION::3cfbd7cc-d83549b-dd8a0247-337198cd;
2024-06-27T20:55:44.167769Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;tx_state=complete;fline=ro_controller.cpp:45;event=CS::INDEXATION;tablet_id=72075186224037888;
2024-06-27T20:55:44.167791Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;fline=manager.cpp:9;event=lock;process_id=CS::INDEXATION::7a961d8d-633922c3-cdb85800-61018aa6;
2024-06-27T20:55:44.167806Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;tx_state=complete;fline=ro_controller.cpp:45;event=CS::INDEXATION;tablet_id=72075186224037889;
2024-06-27T20:55:44.167840Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;fline=columnshard_impl.cpp:651;event=indexation;bytes=646360;blobs_count=1;max_limit=251658240;has_more=0;external_task_id=3cfbd7cc-d83549b-dd8a0247-337198cd;
2024-06-27T20:55:44.167851Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;fline=columnshard_impl.cpp:651;event=indexation;bytes=644032;blobs_count=1;max_limit=251658240;has_more=0;external_task_id=7a961d8d-633922c3-cdb85800-61018aa6;
2024-06-27T20:55:44.168067Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;fline=columnshard_impl.cpp:608;event=start_changes;type=CS::INDEXATION;task_id=3cfbd7cc-d83549b-dd8a0247-337198cd;
2024-06-27T20:55:44.168766Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;fline=columnshard_impl.cpp:608;event=start_changes;type=CS::INDEXATION;task_id=7a961d8d-633922c3-cdb85800-61018aa6;
2024-06-27T20:55:44.168853Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=646162;external_task_id=3cfbd7cc-d83549b-dd8a0247-337198cd;type=CS::INDEXATION;priority=0;;
2024-06-27T20:55:44.168905Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=643840;external_task_id=7a961d8d-633922c3-cdb85800-61018aa6;type=CS::INDEXATION;priority=0;;
2024-06-27T20:55:44.169049Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=actor.cpp:29;event=result_resources;task_id=1;task=cpu=0;mem=646162;external_task_id=3cfbd7cc-d83549b-dd8a0247-337198cd;type=CS::INDEXATION;priority=0;;
2024-06-27T20:55:44.169075Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=task.cpp:9;event=resource_allocated;external_task_id=3cfbd7cc-d83549b-dd8a0247-337198cd;mem=646162;cpu=0;
2024-06-27T20:55:44.169284Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=task.cpp:40;event=allocate_resources;external_task_id=3cfbd7cc-d83549b-dd8a0247-337198cd;task_id=1;mem=646162;cpu=0;
2024-06-27T20:55:44.169346Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=3cfbd7cc-d83549b-dd8a0247-337198cd;fline=task.cpp:110;event=OnDataReady;task=agents_waiting=0;additional_info=();;external_task_id=3cfbd7cc-d83549b-dd8a0247-337198cd;
2024-06-27T20:55:44.169401Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=3cfbd7cc-d83549b-dd8a0247-337198cd;fline=actor.cpp:48;task=agents_waiting=0;additional_info=();;
2024-06-27T20:55:44.169447Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=actor.cpp:29;event=result_resources;task_id=2;task=cpu=0;mem=643840;external_task_id=7a961d8d-633922c3-cdb85800-61018aa6;type=CS::INDEXATION;priority=0;;
2024-06-27T20:55:44.169468Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=task.cpp:9;event=resource_allocated;external_task_id=7a961d8d-633922c3-cdb85800-61018aa6;mem=643840;cpu=0;
2024-06-27T20:55:44.169481Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=task.cpp:40;event=allocate_resources;external_task_id=7a961d8d-633922c3-cdb85800-61018aa6;task_id=2;mem=643840;cpu=0;
2024-06-27T20:55:44.169509Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=7a961d8d-633922c3-cdb85800-61018aa6;fline=task.cpp:110;event=OnDataReady;task=agents_waiting=0;additional_info=();;external_task_id=7a961d8d-633922c3-cdb85800-61018aa6;
2024-06-27T20:55:44.169535Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=7a961d8d-633922c3-cdb85800-61018aa6;fline=actor.cpp:48;task=agents_waiting=0;additional_info=();;
2024-06-27T20:55:44.248276Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:44.248316Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard__write_index.cpp:50;event=TEvWriteIndex;count=1;
2024-06-27T20:55:44.248641Z node 1 :TX_COLUMNSHARD DEBUG: WriteIndex at tablet 72075186224037889
2024-06-27T20:55:44.248807Z node 1 :TX_COLUMNSHARD DEBUG: TxWriteIndex[9] (CS::INDEXATION) apply at tablet 72075186224037889
2024-06-27T20:55:44.249216Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager on execute at tablet 72075186224037889 Save Batch GenStep: 1:2 Blob count: 1
2024-06-27T20:55:44.249264Z node 1 :TX_COLUMNSHARD DEBUG: Index: tables 1 inserted portions=0;blobs=0;rows=0;bytes=0;raw_bytes=0; compacted portions=0;blobs=0;rows=0;bytes=0;raw_bytes=0; s-compacted portions=0;blobs=0;rows=0;bytes=0;raw_bytes=0; inactive portions=0;blobs=0;rows=0;bytes=0;raw_bytes=0; evicted portions=0;blobs=0;rows=0;bytes=0;raw_bytes=0; column records 0 at tablet 72075186224037889
2024-06-27T20:55:44.249283Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;external_task_id=7a961d8d-633922c3-cdb85800-61018aa6;fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037889;
2024-06-27T20:55:44.250748Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=abstract.cpp:45;event=WriteIndexComplete;type=CS::INDEXATION;success=1;
2024-06-27T20:55:44.250918Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 0 in 0 records at tablet 72075186224037889
2024-06-27T20:55:44.250938Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=manager.cpp:14;event=unlock;process_id=CS::INDEXATION::7a961d8d-633922c3-cdb85800-61018aa6;
2024-06-27T20:55:44.250962Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=0;
2024-06-27T20:55:44.250975Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:44.250999Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:44.251025Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:55:44.251040Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:55:44.251052Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889
2024-06-27T20:55:44.251060Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889
2024-06-27T20:55:44.251073Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:55:44.251112Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:55:44.251141Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:44.251158Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:44.251174Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:55:44.251204Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:55:44.251304Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037889 Delete Blob DS:2181038080:[72075186224037889:1:1:3:0:644032:0]
2024-06-27T20:55:44.251323Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037889 Save Batch GenStep: 1:2 Blob count: 1
2024-06-27T20:55:44.251336Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=1;
72075186224037889 SHARING_REMOVE_LOCAL:DS:2181038080:[72075186224037889:1:1:3:0:644032:0] FROM 72075186224037889
72075186224037889 BORROWED_REMOVE_LOCAL:DS:2181038080:[72075186224037889:1:1:3:0:644032:0] FROM 72075186224037889
2024-06-27T20:55:44.251458Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:44.251986Z node 1 :TX_COLUMNSHARD DEBUG: fline=task.cpp:21;event=free_resources;task_id=2;external_task_id=7a961d8d-633922c3-cdb85800-61018aa6;mem=643840;cpu=0;
2024-06-27T20:55:44.272448Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard__write_index.cpp:50;event=TEvWriteIndex;count=1;
2024-06-27T20:55:44.272894Z node 1 :TX_COLUMNSHARD DEBUG: WriteIndex at tablet 72075186224037888
2024-06-27T20:55:44.273059Z node 1 :TX_COLUMNSHARD DEBUG: TxWriteIndex[9] (CS::INDEXATION) apply at tablet 72075186224037888
2024-06-27T20:55:44.273531Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager on execute at tablet 72075186224037888 Save Batch GenStep: 1:2 Blob count: 1
2024-06-27T20:55:44.273593Z node 1 :TX_COLUMNSHARD DEBUG: Index: tables 1 inserted portions=0;blobs=0;rows=0;bytes=0;raw_bytes=0; compacted portions=0;blobs=0;rows=0;bytes=0;raw_bytes=0; s-compacted portions=0;blobs=0;rows=0;bytes=0;raw_bytes=0; inactive portions=0;blobs=0;rows=0;bytes=0;raw_bytes=0; evicted portions=0;blobs=0;rows=0;bytes=0;raw_bytes=0; column records 0 at tablet 72075186224037888
2024-06-27T20:55:44.273615Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;external_task_id=3cfbd7cc-d83549b-dd8a0247-337198cd;fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037888;
2024-06-27T20:55:44.274622Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=abstract.cpp:45;event=WriteIndexComplete;type=CS::INDEXATION;success=1;
2024-06-27T20:55:44.274728Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 0 in 0 records at tablet 72075186224037888
2024-06-27T20:55:44.274743Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=manager.cpp:14;event=unlock;process_id=CS::INDEXATION::3cfbd7cc-d83549b-dd8a0247-337198cd;
2024-06-27T20:55:44.274761Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=0;
2024-06-27T20:55:44.274773Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:44.274790Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:44.274806Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:55:44.274816Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:55:44.274820Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888
2024-06-27T20:55:44.274825Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888
2024-06-27T20:55:44.274836Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:55:44.274854Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:55:44.274868Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:44.274879Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:44.274889Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:55:44.274910Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:55:44.275004Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037888 Delete Blob DS:2181038080:[72075186224037888:1:1:3:0:646360:0]
2024-06-27T20:55:44.275023Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037888 Save Batch GenStep: 1:2 Blob count: 1
2024-06-27T20:55:44.275032Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=1;
72075186224037888 SHARING_REMOVE_LOCAL:DS:2181038080:[72075186224037888:1:1:3:0:646360:0] FROM 72075186224037888
72075186224037888 BORROWED_REMOVE_LOCAL:DS:2181038080:[72075186224037888:1:1:3:0:646360:0] FROM 72075186224037888
2024-06-27T20:55:44.275114Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:44.275410Z node 1 :TX_COLUMNSHARD DEBUG: fline=task.cpp:21;event=free_resources;task_id=1;external_task_id=3cfbd7cc-d83549b-dd8a0247-337198cd;mem=646162;cpu=0;
2024-06-27T20:55:44.320024Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:44.748566Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:44.820262Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:45.033263Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;
2024-06-27T20:55:45.033298Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:45.033419Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521745000 at tablet 72075186224037888
2024-06-27T20:55:45.033449Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:55:45.033465Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:45.033520Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:45.033576Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:55:45.033610Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:55:45.033618Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888
2024-06-27T20:55:45.033651Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888
2024-06-27T20:55:45.033676Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:55:45.033718Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:55:45.033742Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:45.033757Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:45.033779Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:55:45.033841Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:55:45.152488Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037889;
2024-06-27T20:55:45.152517Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:45.152558Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521745000 at tablet 72075186224037889
2024-06-27T20:55:45.152580Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:55:45.152593Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:45.152624Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:45.152672Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:55:45.152693Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:55:45.152705Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889
2024-06-27T20:55:45.152715Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889
2024-06-27T20:55:45.152736Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:55:45.152773Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:55:45.152795Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:45.152805Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:45.152819Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:55:45.152847Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:55:45.248807Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:45.311359Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction
2024-06-27T20:55:45.311470Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction
2024-06-27T20:55:45.320536Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:45.328956Z node 1 :TX_COLUMNSHARD DEBUG: EvScan txId: 281474976715662 scanId: 0 version: {1719521745000:max} readable: {1719521745354:max} at tablet 72075186224037889
2024-06-27T20:55:45.329033Z node 1 :TX_COLUMNSHARD DEBUG: TTxScan prepare txId: 281474976715662 scanId: 0 at tablet 72075186224037889
2024-06-27T20:55:45.329157Z node 1 :TX_COLUMNSHARD DEBUG: EvScan txId: 281474976715662 scanId: 0 version: {1719521745000:max} readable: {1719521745354:max} at tablet 72075186224037888
2024-06-27T20:55:45.329215Z node 1 :TX_COLUMNSHARD DEBUG: TTxScan prepare txId: 281474976715662 scanId: 0 at tablet 72075186224037888
2024-06-27T20:55:45.329406Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=program.cpp:486;program=Command {
  GroupBy {
    Aggregates {
      Column {
        Id: 3
      }
      Function {
        Id: 2
      }
    }
  }
}
Command {
  Projection {
    Columns {
      Id: 3
    }
  }
}
Version: 5
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/"
;
2024-06-27T20:55:45.329563Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=program.cpp:486;program=Command {
  GroupBy {
    Aggregates {
      Column {
        Id: 3
      }
      Function {
        Id: 2
      }
    }
  }
}
Command {
  Projection {
    Columns {
      Id: 3
    }
  }
}
Version: 5
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/"
;
2024-06-27T20:55:45.426593Z node 1 :TX_COLUMNSHARD DEBUG: TTxScan range predicate. From key size: 1 To key size: 0 greater predicate over columns: () less predicate over columns: () at tablet 72075186224037889
2024-06-27T20:55:45.426593Z node 1 :TX_COLUMNSHARD DEBUG: TTxScan range predicate. From key size: 1 To key size: 0 greater predicate over columns: () less predicate over columns: () at tablet 72075186224037888
2024-06-27T20:55:45.442788Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289661022610012:4365];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=681224;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:55:45.442913Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289661022610012:4365];fline=actor.cpp:29;event=result_resources;task_id=3;task=cpu=0;mem=681224;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:55:45.442928Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289661022610012:4365];fline=task.cpp:9;event=resource_allocated;external_task_id=;mem=681224;cpu=0;
2024-06-27T20:55:45.442940Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289661022610012:4365];fline=task.cpp:40;event=allocate_resources;external_task_id=;task_id=3;mem=681224;cpu=0;
2024-06-27T20:55:45.445293Z node 1 :TX_COLUMNSHARD DEBUG: SelfId=[1:7385289661022610012:4365];TabletId=72075186224037888;ScanId=0;TxId=281474976715662;ScanGen=1;method=produce result;fline=task.cpp:21;event=free_resources;task_id=3;external_task_id=;mem=681224;cpu=0;
2024-06-27T20:55:45.447078Z node 1 :TX_COLUMNSHARD DEBUG: Finished read cookie: 2 at tablet 72075186224037888
2024-06-27T20:55:45.452664Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289661022610013:4363];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=678776;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:55:45.452806Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289661022610013:4363];fline=actor.cpp:29;event=result_resources;task_id=4;task=cpu=0;mem=678776;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:55:45.452832Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289661022610013:4363];fline=task.cpp:9;event=resource_allocated;external_task_id=;mem=678776;cpu=0;
2024-06-27T20:55:45.452851Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289661022610013:4363];fline=task.cpp:40;event=allocate_resources;external_task_id=;task_id=4;mem=678776;cpu=0;
2024-06-27T20:55:45.454506Z node 1 :TX_COLUMNSHARD DEBUG: SelfId=[1:7385289661022610013:4363];TabletId=72075186224037889;ScanId=0;TxId=281474976715662;ScanGen=1;method=produce result;fline=task.cpp:21;event=free_resources;task_id=4;external_task_id=;mem=678776;cpu=0;
2024-06-27T20:55:45.456650Z node 1 :TX_COLUMNSHARD DEBUG: Finished read cookie: 2 at tablet 72075186224037889
2024-06-27T20:55:45.457626Z node 1 :KQP_RESOURCE_MANAGER WARN: KqpSnapshotManager: discarding snapshot; our snapshot: [step: 1719521745000, txId: 18446744073709551615] shutting down
2024-06-27T20:55:45.749054Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:45.820753Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:46.033739Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;
2024-06-27T20:55:46.033787Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:46.033875Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521746000 at tablet 72075186224037888
2024-06-27T20:55:46.033921Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:55:46.033951Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:46.033993Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:46.034049Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:55:46.034072Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:55:46.034088Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888
2024-06-27T20:55:46.034104Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888
2024-06-27T20:55:46.034124Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:55:46.034166Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:55:46.034195Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:46.034215Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:46.034233Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:55:46.034280Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:55:46.152993Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037889;
2024-06-27T20:55:46.153030Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:46.153068Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521746000 at tablet 72075186224037889
2024-06-27T20:55:46.153098Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:55:46.153115Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:46.153153Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:46.153205Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:55:46.153240Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:55:46.153255Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889
2024-06-27T20:55:46.153269Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889
2024-06-27T20:55:46.153290Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:55:46.153327Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:55:46.153349Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:46.153364Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:46.153386Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:55:46.153429Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:55:46.249249Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:46.320976Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=actor.cpp:33;event=skip_flush_writing;
SHARING: 72075186224037889->72075186224037888
2024-06-27T20:55:46.459295Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard_impl.cpp:890;process=BlobsSharing;event=TEvProposeFromInitiator;
2024-06-27T20:55:46.460371Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;tx_no=11;tx_info=tx_propose_from_initiator;fline=blobs_sharing_ut.cpp:46;event=sharing_proposed;session_id=a0513f1e-34c7-11ef-9366-e9758fbee1ab;
2024-06-27T20:55:46.749475Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:46.821188Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:47.034166Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;
2024-06-27T20:55:47.034211Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:47.034308Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521747000 at tablet 72075186224037888
2024-06-27T20:55:47.034334Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:55:47.034356Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:47.034389Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:47.034426Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:55:47.034450Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:55:47.034459Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888
2024-06-27T20:55:47.034470Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888
2024-06-27T20:55:47.034488Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:55:47.034517Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:55:47.034540Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:47.034557Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:47.034575Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:55:47.034633Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:55:47.153428Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037889;
2024-06-27T20:55:47.153487Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:47.153524Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521747000 at tablet 72075186224037889
2024-06-27T20:55:47.153572Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:55:47.153590Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:47.153628Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:47.153685Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:55:47.153710Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:55:47.153721Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889
2024-06-27T20:55:47.153734Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889
2024-06-27T20:55:47.153759Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:55:47.153804Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:55:47.153830Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:47.153866Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:47.153895Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:55:47.153952Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:55:47.193400Z node 1 :METADATA_PROVIDER ERROR: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[1:7385289648137707175:4098];send_to=[0:7307199536658146131:7762515];
2024-06-27T20:55:47.193471Z node 1 :METADATA_PROVIDER ERROR: fline=accessor_snapshot_base.cpp:68;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=timeout;
2024-06-27T20:55:47.249746Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:47.321371Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=actor.cpp:33;event=skip_flush_writing;
WAIT_PROPOSING...
2024-06-27T20:55:47.459398Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard_impl.cpp:913;process=BlobsSharing;event=TEvConfirmFromInitiator;
2024-06-27T20:55:47.460885Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;tx_no=12;tx_info=tx_confirm_from_initiator;fline=blobs_sharing_ut.cpp:50;event=sharing_confirmed;session_id=a0513f1e-34c7-11ef-9366-e9758fbee1ab;
2024-06-27T20:55:47.749968Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:47.821646Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:48.034635Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;
2024-06-27T20:55:48.034677Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:48.034747Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521748000 at tablet 72075186224037888
2024-06-27T20:55:48.034781Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:55:48.034801Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:48.034862Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;sessions=start;tablet_id=72075186224037888;info=dest_proto;fline=manager.cpp:9;event=lock;process_id=sharing_session:a0513f1e-34c7-11ef-9366-e9758fbee1ab;
2024-06-27T20:55:48.034908Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;sessions=start;tablet_id=72075186224037888;info=dest_proto;fline=common.cpp:17;info=Start;
2024-06-27T20:55:48.035068Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:48.035131Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:55:48.035156Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:55:48.035166Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888
2024-06-27T20:55:48.035177Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888
2024-06-27T20:55:48.035177Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard_impl.cpp:929;process=BlobsSharing;event=TEvStartToSource;
2024-06-27T20:55:48.035195Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:55:48.035222Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:55:48.035243Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:48.035259Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:48.035277Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:55:48.035319Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:55:48.036400Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_no=11;tx_info=tx_start_to_source;fline=tx_start_to_source.cpp:15;info=TTxStartToSource::Complete;
2024-06-27T20:55:48.153872Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037889;
2024-06-27T20:55:48.153910Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:48.153948Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521748000 at tablet 72075186224037889
2024-06-27T20:55:48.153973Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:55:48.153988Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:48.154051Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;sessions=start;tablet_id=72075186224037889;info=source_proto;fline=manager.cpp:9;event=lock;process_id=sharing_session:a0513f1e-34c7-11ef-9366-e9758fbee1ab;
2024-06-27T20:55:48.154085Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;sessions=start;tablet_id=72075186224037889;info=source_proto;fline=common.cpp:17;info=Start;
2024-06-27T20:55:48.154602Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:48.154628Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard_impl.cpp:944;process=BlobsSharing;event=TEvSendDataFromSource;
2024-06-27T20:55:48.154648Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:55:48.154668Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:55:48.154693Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889
2024-06-27T20:55:48.154710Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889
2024-06-27T20:55:48.154734Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:55:48.154763Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:55:48.154801Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:48.154827Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:48.154834Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard_impl.cpp:964;event=on_received_data;
2024-06-27T20:55:48.154847Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:55:48.154891Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:55:48.156463Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard_impl.cpp:1038;process=BlobsSharing;event=TEvApplyLinksModification;info=InitiatorTabletId: 72075186224037889
SessionId: "a0513f1e-34c7-11ef-9366-e9758fbee1ab"
PackIdx: 1
Task {
  TasksByStorage {
    TabletId: 72075186224037888
    StorageId: "__DEFAULT"
    InitOwner {
      Blobs {
        BlobId: "DS:2181038080:[72075186224037889:1:2:4:0:168096:0]"
        TabletId: 72075186224037889
      }
    }
    AddSharingLinks {
    }
    RemoveSharingLinks {
    }
  }
}
;
2024-06-27T20:55:48.156464Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard_impl.cpp:1038;process=BlobsSharing;event=TEvApplyLinksModification;info=InitiatorTabletId: 72075186224037889
SessionId: "a0513f1e-34c7-11ef-9366-e9758fbee1ab"
PackIdx: 1
Task {
  TasksByStorage {
    TabletId: 72075186224037889
    StorageId: "__DEFAULT"
    InitOwner {
    }
    AddSharingLinks {
      Blobs {
        BlobId: "DS:2181038080:[72075186224037889:1:2:4:0:168096:0]"
        TabletIds: 72075186224037889
        TabletIds: 72075186224037888
      }
    }
    RemoveSharingLinks {
    }
  }
}
;
2024-06-27T20:55:48.157218Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard_impl.cpp:970;process=BlobsSharing;event=TEvAckDataToSource;
2024-06-27T20:55:48.157253Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=cursor.h:50;event=SourceAckData;pack=1;pack_ack=1;links_ready=0;links_waiting=2;
2024-06-27T20:55:48.157282Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard_impl.cpp:981;event=on_ack_data;
2024-06-27T20:55:48.157397Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard_impl.cpp:1052;process=BlobsSharing;event=TEvApplyLinksModificationFinished;
2024-06-27T20:55:48.157432Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=cursor.h:60;event=SourceAckData;pack=1;pack_ack=1;links_ready=1;links_waiting=2;
2024-06-27T20:55:48.157457Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard_impl.cpp:1064;event=on_change_links_finish;tablet_id=72075186224037888;
2024-06-27T20:55:48.157828Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard_impl.cpp:1052;process=BlobsSharing;event=TEvApplyLinksModificationFinished;
2024-06-27T20:55:48.157854Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=cursor.h:60;event=SourceAckData;pack=1;pack_ack=1;links_ready=2;links_waiting=2;
2024-06-27T20:55:48.157881Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard_impl.cpp:1064;event=on_change_links_finish;tablet_id=72075186224037889;
2024-06-27T20:55:48.159184Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_no=15;tx_info=ack_to_source_on_ack_links;fline=manager.cpp:14;event=unlock;process_id=sharing_session:a0513f1e-34c7-11ef-9366-e9758fbee1ab;
2024-06-27T20:55:48.159248Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard_impl.cpp:1004;process=BlobsSharing;event=TEvFinishedFromSource;
2024-06-27T20:55:48.159286Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard_impl.cpp:1015;event=on_finished_data;
2024-06-27T20:55:48.160164Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard_impl.cpp:987;process=BlobsSharing;event=TEvAckFinishToSource;
2024-06-27T20:55:48.160202Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard_impl.cpp:998;event=on_ack_finish;
__DEFAULT
    DS:2181038080:[72075186224037889:1:2:4:0:168096:0]
        O: 72075186224037889
        S: 72075186224037888,72075186224037889
2024-06-27T20:55:48.160303Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_no=15;tx_info=;fline=manager.cpp:14;event=unlock;process_id=sharing_session:a0513f1e-34c7-11ef-9366-e9758fbee1ab;
2024-06-27T20:55:48.160337Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;tx_no=15;tx_info=;fline=blobs_sharing_ut.cpp:54;event=sharing_finished;session_id=a0513f1e-34c7-11ef-9366-e9758fbee1ab;
2024-06-27T20:55:48.250168Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:48.321853Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=actor.cpp:33;event=skip_flush_writing;
WAIT_CONFIRMED...
FALLBACK_ACTOR_LOGGING;priority=WARN;component=332;fline=controller.cpp:117;reason=non_trivial;
2024-06-27T20:55:48.467016Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction
2024-06-27T20:55:48.467124Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction
2024-06-27T20:55:48.469176Z node 1 :TX_COLUMNSHARD DEBUG: EvScan txId: 281474976715664 scanId: 0 version: {1719521748000:max} readable: {1719521748511:max} at tablet 72075186224037889
2024-06-27T20:55:48.469195Z node 1 :TX_COLUMNSHARD DEBUG: EvScan txId: 281474976715664 scanId: 0 version: {1719521748000:max} readable: {1719521748511:max} at tablet 72075186224037888
2024-06-27T20:55:48.469231Z node 1 :TX_COLUMNSHARD DEBUG: TTxScan prepare txId: 281474976715664 scanId: 0 at tablet 72075186224037889
2024-06-27T20:55:48.469233Z node 1 :TX_COLUMNSHARD DEBUG: TTxScan prepare txId: 281474976715664 scanId: 0 at tablet 72075186224037888
2024-06-27T20:55:48.469536Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=program.cpp:486;program=Command {
  GroupBy {
    Aggregates {
      Column {
        Id: 3
      }
      Function {
        Id: 2
      }
    }
  }
}
Command {
  Projection {
    Columns {
      Id: 3
    }
  }
}
Version: 5
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/"
;
2024-06-27T20:55:48.469536Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=program.cpp:486;program=Command {
  GroupBy {
    Aggregates {
      Column {
        Id: 3
      }
      Function {
        Id: 2
      }
    }
  }
}
Command {
  Projection {
    Columns {
      Id: 3
    }
  }
}
Version: 5
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/"
;
2024-06-27T20:55:48.470041Z node 1 :TX_COLUMNSHARD DEBUG: TTxScan range predicate. From key size: 1 To key size: 0 greater predicate over columns: () less predicate over columns: () at tablet 72075186224037888
2024-06-27T20:55:48.470041Z node 1 :TX_COLUMNSHARD DEBUG: TTxScan range predicate. From key size: 1 To key size: 0 greater predicate over columns: () less predicate over columns: () at tablet 72075186224037889
2024-06-27T20:55:48.493083Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289673907511993:4351];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=678776;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:55:48.493232Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289673907511993:4351];fline=actor.cpp:29;event=result_resources;task_id=5;task=cpu=0;mem=678776;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:55:48.493252Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289673907511993:4351];fline=task.cpp:9;event=resource_allocated;external_task_id=;mem=678776;cpu=0;
2024-06-27T20:55:48.493274Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289673907511993:4351];fline=task.cpp:40;event=allocate_resources;external_task_id=;task_id=5;mem=678776;cpu=0;
2024-06-27T20:55:48.493943Z node 1 :TX_COLUMNSHARD DEBUG: SelfId=[1:7385289673907511993:4351];TabletId=72075186224037889;ScanId=0;TxId=281474976715664;ScanGen=1;method=produce result;fline=task.cpp:21;event=free_resources;task_id=5;external_task_id=;mem=678776;cpu=0;
2024-06-27T20:55:48.496430Z node 1 :TX_COLUMNSHARD DEBUG: Finished read cookie: 3 at tablet 72075186224037889
2024-06-27T20:55:48.496544Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289673907511992:4365];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=961728;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:55:48.496588Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289673907511992:4365];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=1920000;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:55:48.496617Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289673907511992:4365];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=958272;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:55:48.496670Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289673907511992:4365];fline=actor.cpp:29;event=result_resources;task_id=6;task=cpu=0;mem=961728;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:55:48.496694Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289673907511992:4365];fline=task.cpp:9;event=resource_allocated;external_task_id=;mem=961728;cpu=0;
2024-06-27T20:55:48.496713Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289673907511992:4365];fline=task.cpp:40;event=allocate_resources;external_task_id=;task_id=6;mem=961728;cpu=0;
2024-06-27T20:55:48.496770Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289673907511992:4365];fline=actor.cpp:29;event=result_resources;task_id=7;task=cpu=0;mem=1920000;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:55:48.496786Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289673907511992:4365];fline=task.cpp:9;event=resource_allocated;external_task_id=;mem=1920000;cpu=0;
2024-06-27T20:55:48.496800Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289673907511992:4365];fline=task.cpp:40;event=allocate_resources;external_task_id=;task_id=7;mem=1920000;cpu=0;
2024-06-27T20:55:48.496836Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289673907511992:4365];fline=actor.cpp:29;event=result_resources;task_id=8;task=cpu=0;mem=958272;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:55:48.496851Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289673907511992:4365];fline=task.cpp:9;event=resource_allocated;external_task_id=;mem=958272;cpu=0;
2024-06-27T20:55:48.496869Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289673907511992:4365];fline=task.cpp:40;event=allocate_resources;external_task_id=;task_id=8;mem=958272;cpu=0;
2024-06-27T20:55:48.497191Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=;fline=actor.cpp:48;task=agents_waiting=1;additional_info=();;
2024-06-27T20:55:48.497714Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=;fline=actor.cpp:48;task=agents_waiting=1;additional_info=();;
2024-06-27T20:55:48.497715Z node 1 :TX_COLUMNSHARD DEBUG: fline=task.cpp:110;event=OnDataReady;task=agents_waiting=0;additional_info=();;external_task_id=;
2024-06-27T20:55:48.498121Z node 1 :TX_COLUMNSHARD DEBUG: fline=task.cpp:110;event=OnDataReady;task=agents_waiting=0;additional_info=();;external_task_id=;
2024-06-27T20:55:48.502621Z node 1 :TX_COLUMNSHARD DEBUG: SelfId=[1:7385289673907511992:4365];TabletId=72075186224037888;ScanId=0;TxId=281474976715664;ScanGen=1;method=produce result;fline=task.cpp:21;event=free_resources;task_id=6;external_task_id=;mem=961728;cpu=0;
2024-06-27T20:55:48.666157Z node 1 :TX_COLUMNSHARD DEBUG: SelfId=[1:7385289673907511992:4365];TabletId=72075186224037888;ScanId=0;TxId=281474976715664;ScanGen=1;method=produce result;fline=task.cpp:21;event=free_resources;task_id=7;external_task_id=;mem=1920000;cpu=0;
2024-06-27T20:55:48.666387Z node 1 :TX_COLUMNSHARD DEBUG: SelfId=[1:7385289673907511992:4365];TabletId=72075186224037888;ScanId=0;TxId=281474976715664;ScanGen=1;method=produce result;fline=task.cpp:21;event=free_resources;task_id=8;external_task_id=;mem=958272;cpu=0;
2024-06-27T20:55:48.667428Z node 1 :KQP_RESOURCE_MANAGER WARN: KqpSnapshotManager: discarding snapshot; our snapshot: [step: 1719521748000, txId: 18446744073709551615] shutting down
2024-06-27T20:55:48.669012Z node 1 :TX_COLUMNSHARD DEBUG: Finished read cookie: 3 at tablet 72075186224037888
FALLBACK_ACTOR_LOGGING;priority=DEBUG;component=2100;fline=native.cpp:101;event=serialize;size=640144;columns=1;
2024-06-27T20:55:48.689787Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=column_engine.cpp:22;total=202798006272;kff=0.3;
2024-06-27T20:55:48.689812Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=column_engine.cpp:22;total=202798006272;kff=0.3;
2024-06-27T20:55:48.690029Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=column_engine.cpp:22;total=202798006272;kff=0.3;
2024-06-27T20:55:48.690045Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=column_engine.cpp:22;total=202798006272;kff=0.3;
2024-06-27T20:55:48.690170Z node 1 :TX_COLUMNSHARD DEBUG: Write (blob) 319992 bytes into pathId 3 {object=write_monitor;count=1;size=319992} at tablet 72075186224037889
2024-06-27T20:55:48.690174Z node 1 :TX_COLUMNSHARD DEBUG: Write (blob) 320296 bytes into pathId 3 {object=write_monitor;count=1;size=320296} at tablet 72075186224037888
2024-06-27T20:55:49.394318Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037889;
2024-06-27T20:55:49.394358Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:49.394402Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385289648137707794:11];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:49.394465Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385289648137707793:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:55:49.394557Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;
2024-06-27T20:55:49.394581Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:49.402690Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521749000 at tablet 72075186224037889
2024-06-27T20:55:49.402735Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:55:49.402752Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:49.402788Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:49.402836Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:55:49.402860Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:55:49.402874Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889
2024-06-27T20:55:49.402885Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889
2024-06-27T20:55:49.402904Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:55:49.402935Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:55:49.402961Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:49.402988Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:49.403005Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:55:49.403049Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385289648137707794:11];tablet_id=72075186224037889;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:55:49.502085Z node 1 :TX_COLUMNSHARD_SCAN WARN: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet=72075186224037888;fline=tx_internal_scan.cpp:54;event=TTxScan failed;reason=no metadata;
VERIFY failed (2024-06-27T20:55:49.513203Z): tablet_id=72075186224037888;verification=false;fline=actor.h:66;
  ydb/library/actors/core/log.cpp:744
  ~TVerifyFormattedRecordWriter(): requirement false failed
2024-06-27T20:55:49.570346Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521749000 at tablet 72075186224037888
2024-06-27T20:55:49.570387Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:55:49.570404Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:55:49.570442Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:55:49.570487Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:55:49.570515Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:55:49.570525Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888
2024-06-27T20:55:49.570536Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888
2024-06-27T20:55:49.570556Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:55:49.570587Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:55:49.570615Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:49.570633Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:55:49.570661Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:55:49.570706Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385289648137707793:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:55:49.571042Z node 1 :TX_COLUMNSHARD_SCAN WARN: tablet=72075186224037889;fline=tx_internal_scan.cpp:54;event=TTxScan failed;reason=no metadata;
0. /-S/util/system/yassert.cpp:83: NPrivate::InternalPanicImpl @ 0x1889DDC0
1. /-S/util/system/yassert.cpp:55: NPrivate::Panic @ 0x18888AA0
2. /-S/ydb/library/actors/core/log.cpp:744: NActors::TVerifyFormattedRecordWriter::~TVerifyFormattedRecordWriter @ 0x1BA4595D
3. /-S/ydb/core/tx/columnshard/data_reader/actor.h:66: NKikimr::NOlap::NDataReader::TActor::HandleExecute @ 0x39E5B587
4. /-S/ydb/core/tx/columnshard/data_reader/actor.h:82: NKikimr::NOlap::NDataReader::TActor::StateFunc @ 0x39E56F19
5. /-S/ydb/library/actors/core/actor.h:532: NActors::IActor::Receive @ 0x1B9F6C43
6. /-S/ydb/library/actors/core/executor_thread.cpp:251: NActors::TGenericExecutorThread::Execute<NActors::TMailboxTable::THTSwapMailbox> @ 0x1B9DAE8F
7. /-S/ydb/library/actors/core/executor_thread.cpp:439: NActors::TGenericExecutorThread::ProcessExecutorPool(NActors::IExecutorPool *)::(anonymous class)::operator() @ 0x1B9BF4BF
8. /-S/ydb/library/actors/core/executor_thread.cpp:492: NActors::TGenericExecutorThread::ProcessExecutorPool @ 0x1B9BDF9F
9. /-S/ydb/library/actors/core/executor_thread.cpp:523: NActors::TExecutorThread::ThreadProc @ 0x1B9C12BB
10. /-S/util/system/thread.cpp:244: (anonymous namespace)::TPosixThread::ThreadProxy @ 0x188AD8E3
11. ??:0: ?? @ 0x7FE2B4AFDAC2
12. ??:0: ?? @ 0x7FE2B4B8F84F