Trying to start YDB, gRPC: 18101, MsgBus: 1969
2024-06-27T20:49:35.439426Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction
2024-06-27T20:49:35.439759Z node 1 :METADATA_PROVIDER WARN: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[1:7385288074657051033:4098];send_to=[0:7307199536658146131:7762515];
2024-06-27T20:49:35.439768Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction
2024-06-27T20:49:35.439913Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction
2024-06-27T20:49:35.439949Z 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/bsv3/002c7d/r3tmp/tmpHiYUtG/pdisk_1.dat
2024-06-27T20:49:35.489281Z node 1 :IMPORT WARN: Table profiles were not loaded
TServer::EnableGrpc on GrpcPort 18101, node 1
2024-06-27T20:49:35.503998Z node 1 :NET_CLASSIFIER WARN: distributable config is empty, broken or outdated, will use file: (empty maybe)
2024-06-27T20:49:35.504006Z node 1 :NET_CLASSIFIER WARN: will try to initialize from file: (empty maybe)
2024-06-27T20:49:35.504008Z node 1 :NET_CLASSIFIER WARN: failed to initialize from file: (empty maybe)
2024-06-27T20:49:35.504041Z node 1 :NET_CLASSIFIER ERROR: got bad distributable configuration
TClient is connected to server localhost:1969
TClient is connected to server localhost:1969
WaitRootIsUp 'Root'...
TClient::Ls request: Root
TClient::Ls response: 2024-06-27T20:49:35.540597Z node 1 :HIVE WARN: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2024-06-27T20:49:35.540622Z node 1 :HIVE WARN: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2024-06-27T20:49:35.546724Z node 1 :HIVE WARN: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Connecting -> Connected
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:49:35.566706Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard.cpp:68;event=initialize_shard;step=OnActivateExecutor;
2024-06-27T20:49:35.566706Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard.cpp:68;event=initialize_shard;step=OnActivateExecutor;
2024-06-27T20:49:35.572622Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard.cpp:84;event=initialize_shard;step=initialize_tiring_finished;
2024-06-27T20:49:35.572661Z node 1 :TX_COLUMNSHARD DEBUG: TxInitSchema.Execute at tablet 72075186224037889
2024-06-27T20:49:35.574022Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard.cpp:84;event=initialize_shard;step=initialize_tiring_finished;
2024-06-27T20:49:35.574053Z node 1 :TX_COLUMNSHARD DEBUG: TxInitSchema.Execute at tablet 72075186224037888
2024-06-27T20:49:35.574297Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051645:5];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:35.574303Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051643:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:35.577892Z node 1 :TX_COLUMNSHARD DEBUG: TxInitSchema.Complete at tablet 72075186224037889
2024-06-27T20:49:35.577933Z 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:49:35.577939Z 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:49:35.577962Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=normalizer.cpp:127;normalizer=TGranulesNormalizer;message=0 chunks found;
2024-06-27T20:49:35.577996Z 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:49:35.578008Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=chunks.cpp:132;normalizer=TChunksNormalizer;message=0 chunks found;
2024-06-27T20:49:35.578017Z 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:49:35.578080Z 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:49:35.578097Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=normalizer.cpp:123;normalizer=TGranulesNormalizer;message=0 chunks found;
2024-06-27T20:49:35.578105Z 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:49:35.578127Z node 1 :TX_COLUMNSHARD DEBUG: TxInitSchema.Complete at tablet 72075186224037888
2024-06-27T20:49:35.578128Z 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:49:35.578137Z 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:49:35.578144Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:294;step=TTxUpdateSchema.Execute_Finish;
2024-06-27T20:49:35.578151Z 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:49:35.578160Z 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:49:35.578179Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=normalizer.cpp:127;normalizer=TGranulesNormalizer;message=0 chunks found;
2024-06-27T20:49:35.578202Z 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:49:35.578205Z node 1 :TX_COLUMNSHARD DEBUG: fline=columnshard.cpp:75;event=tiering_new_event;
2024-06-27T20:49:35.578213Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard_impl.cpp:1123;event=OnTieringModified;path_id=NO_VALUE_OPTIONAL;
2024-06-27T20:49:35.578214Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=chunks.cpp:132;normalizer=TChunksNormalizer;message=0 chunks found;
2024-06-27T20:49:35.578223Z 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:49:35.578260Z 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:49:35.578275Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=normalizer.cpp:123;normalizer=TGranulesNormalizer;message=0 chunks found;
2024-06-27T20:49:35.578286Z 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:49:35.578307Z 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:49:35.578318Z 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:49:35.578325Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:294;step=TTxUpdateSchema.Execute_Finish;
2024-06-27T20:49:35.578350Z node 1 :TX_COLUMNSHARD DEBUG: fline=columnshard.cpp:75;event=tiering_new_event;
2024-06-27T20:49:35.578360Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard_impl.cpp:1123;event=OnTieringModified;path_id=NO_VALUE_OPTIONAL;
2024-06-27T20:49:35.578992Z node 1 :TX_COLUMNSHARD INFO: fline=columnshard__init.cpp:299;step=TTxUpdateSchema.Complete;
2024-06-27T20:49:35.579034Z node 1 :TX_COLUMNSHARD DEBUG: TTxInit.Execute at tablet 72075186224037889
2024-06-27T20:49:35.579114Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:104;step=TInsertTable::Load_Start;
2024-06-27T20:49:35.579281Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:111;step=TInsertTable::Load_Finish;
2024-06-27T20:49:35.579290Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:116;step=TTxController::Load_Start;
2024-06-27T20:49:35.579297Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:123;step=TTxController::Load_Finish;
2024-06-27T20:49:35.579302Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:128;step=TOperationsManager::Load_Start;
2024-06-27T20:49:35.579314Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:135;step=TOperationsManager::Load_Finish;
2024-06-27T20:49:35.579318Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:140;step=TStoragesManager::Load_Start;
2024-06-27T20:49:35.579376Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=0;
2024-06-27T20:49:35.579384Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:146;step=TStoragesManager::Load_Finish;
2024-06-27T20:49:35.579388Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:150;step=TTablesManager::Load_Start;
2024-06-27T20:49:35.579413Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:171;step=TTablesManager::Load_Finish;
2024-06-27T20:49:35.579446Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 0 in 0 records at tablet 72075186224037889
2024-06-27T20:49:35.579465Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard.cpp:47;event=initialize_shard;step=SwitchToWork;
2024-06-27T20:49:35.579476Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard.cpp:55;event=initialize_shard;step=SignalTabletActive;
2024-06-27T20:49:35.579479Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037889;
2024-06-27T20:49:35.579490Z node 1 :TX_COLUMNSHARD INFO: fline=columnshard__init.cpp:299;step=TTxUpdateSchema.Complete;
2024-06-27T20:49:35.579499Z node 1 :TX_COLUMNSHARD DEBUG: TTxInit.Execute at tablet 72075186224037888
2024-06-27T20:49:35.579555Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:104;step=TInsertTable::Load_Start;
2024-06-27T20:49:35.579571Z node 1 :TX_COLUMNSHARD DEBUG: fline=column_engine.cpp:22;total=202797998080;kff=0.3;
2024-06-27T20:49:35.579604Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=0;
2024-06-27T20:49:35.579607Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:35.579609Z node 1 :TX_COLUMNSHARD DEBUG: Disabled periodic stats at tablet 72075186224037889
2024-06-27T20:49:35.579611Z 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:49:35.579635Z 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:49:35.579642Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037889;
2024-06-27T20:49:35.579643Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:35.579644Z node 1 :TX_COLUMNSHARD DEBUG: Disabled periodic stats at tablet 72075186224037889
2024-06-27T20:49:35.579700Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:111;step=TInsertTable::Load_Finish;
2024-06-27T20:49:35.579707Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:116;step=TTxController::Load_Start;
2024-06-27T20:49:35.579712Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:123;step=TTxController::Load_Finish;
2024-06-27T20:49:35.579715Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:128;step=TOperationsManager::Load_Start;
2024-06-27T20:49:35.579735Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:135;step=TOperationsManager::Load_Finish;
2024-06-27T20:49:35.579738Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:140;step=TStoragesManager::Load_Start;
2024-06-27T20:49:35.579770Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=0;
2024-06-27T20:49:35.579784Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:146;step=TStoragesManager::Load_Finish;
2024-06-27T20:49:35.579787Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:150;step=TTablesManager::Load_Start;
2024-06-27T20:49:35.579801Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:171;step=TTablesManager::Load_Finish;
2024-06-27T20:49:35.579818Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 0 in 0 records at tablet 72075186224037888
2024-06-27T20:49:35.579831Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard.cpp:47;event=initialize_shard;step=SwitchToWork;
2024-06-27T20:49:35.579840Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard.cpp:55;event=initialize_shard;step=SignalTabletActive;
2024-06-27T20:49:35.579849Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037888;
2024-06-27T20:49:35.579945Z node 1 :TX_COLUMNSHARD DEBUG: fline=column_engine.cpp:22;total=202797998080;kff=0.3;
2024-06-27T20:49:35.579982Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=0;
2024-06-27T20:49:35.579985Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:35.579987Z node 1 :TX_COLUMNSHARD DEBUG: Disabled periodic stats at tablet 72075186224037888
2024-06-27T20:49:35.579990Z 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:49:35.580015Z 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:49:35.580028Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;
2024-06-27T20:49:35.580029Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:35.580030Z node 1 :TX_COLUMNSHARD DEBUG: Disabled periodic stats at tablet 72075186224037888
2024-06-27T20:49:35.612866Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037888
2024-06-27T20:49:35.612881Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037889
2024-06-27T20:49:35.613809Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;tx_id=281474976715658;this=77178324921120;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:1;;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:1;;fline=tx_controller.cpp:292;event=start;
2024-06-27T20:49:35.613826Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;tx_id=281474976715658;this=77178324921120;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:1;;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:1;;fline=schema.h:35;event=sync_schema;
2024-06-27T20:49:35.613814Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;tx_id=281474976715658;this=77178324920960;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:1;;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:1;;fline=tx_controller.cpp:292;event=start;
2024-06-27T20:49:35.613840Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;tx_id=281474976715658;this=77178324920960;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:1;;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:1;;fline=schema.h:35;event=sync_schema;
2024-06-27T20:49:35.613847Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;tx_id=281474976715658;this=77178324921120;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:1;;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:1;;fline=tx_controller.cpp:319;event=registered;
2024-06-27T20:49:35.613884Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;tx_id=281474976715658;this=77178324920960;method=TTxController::StartProposeOnExecute;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:1;;tx_info=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:1;;fline=tx_controller.cpp:319;event=registered;
2024-06-27T20:49:35.614847Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;request_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:1;;this=77178324921120;op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:1;;int_op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:1;;fline=columnshard__propose_transaction.cpp:94;event=actual tx operator;
2024-06-27T20:49:35.614848Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;request_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:1;;this=77178324920960;op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:1;;int_op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:1;;fline=columnshard__propose_transaction.cpp:94;event=actual tx operator;
2024-06-27T20:49:35.614858Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;request_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:1;;this=77178324920960;op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:1;;int_op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325: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:7385288074657051325:12333];cookie=12:1;;
2024-06-27T20:49:35.614863Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;request_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:1;;this=77178324921120;op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:1;;int_op_tx=281474976715658:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325: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:7385288074657051325:12333];cookie=22:1;;
2024-06-27T20:49:35.615074Z node 1 :TX_COLUMNSHARD DEBUG: Registered with mediator time cast at tablet 72075186224037889
2024-06-27T20:49:35.615084Z node 1 :TX_COLUMNSHARD DEBUG: Registered with mediator time cast at tablet 72075186224037888
2024-06-27T20:49:35.615512Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037888
2024-06-27T20:49:35.615529Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037889
2024-06-27T20:49:35.615533Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719521375663 at tablet 72075186224037889, mediator 72057594046382081
2024-06-27T20:49:35.615540Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[2] execute at tablet 72075186224037889
2024-06-27T20:49:35.615558Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037889;
2024-06-27T20:49:35.615598Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719521375663 at tablet 72075186224037888, mediator 72057594046382081
2024-06-27T20:49:35.615607Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[2] execute at tablet 72075186224037888
2024-06-27T20:49:35.615620Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037888;
2024-06-27T20:49:35.616053Z node 1 :TX_COLUMNSHARD DEBUG: TTxNotifyTxCompletion.Execute at tablet 72075186224037888
2024-06-27T20:49:35.616085Z node 1 :TX_COLUMNSHARD DEBUG: TTxNotifyTxCompletion.Execute at tablet 72075186224037889
2024-06-27T20:49:35.616352Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[2] complete at tablet 72075186224037889
2024-06-27T20:49:35.616360Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[2] complete at tablet 72075186224037888
2024-06-27T20:49:35.616378Z 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:49:35.616378Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;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:49:35.618175Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;tx_id=281474976715659;this=77178324920960;method=TTxController::StartProposeOnExecute;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:2;;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:2;;fline=tx_controller.cpp:292;event=start;
2024-06-27T20:49:35.618190Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;tx_id=281474976715659;this=77178324921120;method=TTxController::StartProposeOnExecute;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:2;;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:2;;fline=tx_controller.cpp:292;event=start;
2024-06-27T20:49:35.618210Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;tx_id=281474976715659;this=77178324921120;method=TTxController::StartProposeOnExecute;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:2;;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:2;;fline=schema.h:35;event=sync_schema;
2024-06-27T20:49:35.618213Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;tx_id=281474976715659;this=77178324920960;method=TTxController::StartProposeOnExecute;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:2;;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:2;;fline=schema.h:35;event=sync_schema;
2024-06-27T20:49:35.618228Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;tx_id=281474976715659;this=77178324921120;method=TTxController::StartProposeOnExecute;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:2;;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:2;;fline=tx_controller.cpp:319;event=registered;
2024-06-27T20:49:35.618235Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;tx_id=281474976715659;this=77178324920960;method=TTxController::StartProposeOnExecute;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:2;;tx_info=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:2;;fline=tx_controller.cpp:319;event=registered;
2024-06-27T20:49:35.618943Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;request_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:2;;this=77178324920960;op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:2;;int_op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:2;;fline=columnshard__propose_transaction.cpp:94;event=actual tx operator;
2024-06-27T20:49:35.618955Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;request_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:2;;this=77178324920960;op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=12:2;;int_op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325: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:7385288074657051325:12333];cookie=12:2;;
2024-06-27T20:49:35.618992Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;request_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:2;;this=77178324921120;op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:2;;int_op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:2;;fline=columnshard__propose_transaction.cpp:94;event=actual tx operator;
2024-06-27T20:49:35.619010Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;request_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:2;;this=77178324921120;op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325:12333];cookie=22:2;;int_op_tx=281474976715659:TX_KIND_SCHEMA;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051325: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:7385288074657051325:12333];cookie=22:2;;
2024-06-27T20:49:35.620537Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719521375670 at tablet 72075186224037888, mediator 72057594046382081
2024-06-27T20:49:35.620549Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719521375670 at tablet 72075186224037889, mediator 72057594046382081
2024-06-27T20:49:35.620555Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[4] execute at tablet 72075186224037888
2024-06-27T20:49:35.620557Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[4] execute at tablet 72075186224037889
2024-06-27T20:49:35.620573Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037888;
2024-06-27T20:49:35.620575Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037889;
2024-06-27T20:49:35.620600Z node 1 :TX_COLUMNSHARD DEBUG: EnsureTable for pathId: 3 ttl settings: {  } at tablet 72075186224037888
2024-06-27T20:49:35.620610Z node 1 :TX_COLUMNSHARD DEBUG: EnsureTable for pathId: 3 ttl settings: {  } at tablet 72075186224037889
2024-06-27T20:49:35.622456Z 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:49:35.622456Z 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:49:35.622476Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=execute;fline=tables_manager.cpp:257;method=RegisterTable;path_id=3;
2024-06-27T20:49:35.622480Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=execute;fline=column_engine.h:282;event=RegisterTable;path_id=3;
2024-06-27T20:49:35.622492Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=execute;fline=tables_manager.cpp:257;method=RegisterTable;path_id=3;
2024-06-27T20:49:35.622495Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=execute;fline=column_engine.h:282;event=RegisterTable;path_id=3;
2024-06-27T20:49:35.623062Z node 1 :TX_COLUMNSHARD DEBUG: TTxNotifyTxCompletion.Execute at tablet 72075186224037889
2024-06-27T20:49:35.623155Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[4] complete at tablet 72075186224037889
2024-06-27T20:49:35.623178Z 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:49:35.623274Z node 1 :TX_COLUMNSHARD DEBUG: TTxNotifyTxCompletion.Execute at tablet 72075186224037888
2024-06-27T20:49:35.623322Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[4] complete at tablet 72075186224037888
2024-06-27T20:49:35.623343Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
FALLBACK_ACTOR_LOGGING;priority=TRACE;component=2100;fline=native.cpp:67;event=parsing;size=640144;columns=1;
FALLBACK_ACTOR_LOGGING;priority=DEBUG;component=2100;fline=native.cpp:101;event=serialize;size=640144;columns=1;
2024-06-27T20:49:35.633690Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037889
2024-06-27T20:49:35.633725Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037888
2024-06-27T20:49:35.633825Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=column_engine.cpp:22;total=202797998080;kff=0.3;
2024-06-27T20:49:35.633827Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=column_engine.cpp:22;total=202797998080;kff=0.3;
2024-06-27T20:49:35.633881Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=column_engine.cpp:22;total=202797998080;kff=0.3;
2024-06-27T20:49:35.633914Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=column_engine.cpp:22;total=202797998080;kff=0.3;
2024-06-27T20:49:35.633917Z 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:49:35.633951Z 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:49:35.814184Z node 1 :TX_COLUMNSHARD DEBUG: Finished read cookie: 1 at tablet 72075186224037888
2024-06-27T20:49:35.833093Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;fline=actor.cpp:24;event=restore_task_finished;reason=;
2024-06-27T20:49:35.833692Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051643:10];fline=actor.cpp:22;event=flush_writing;size=320720;count=1;
2024-06-27T20:49:35.851064Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;fline=actor.cpp:24;event=restore_task_finished;reason=;
2024-06-27T20:49:35.851669Z node 1 :TX_COLUMNSHARD DEBUG: Finished read cookie: 1 at tablet 72075186224037889
2024-06-27T20:49:35.889206Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051645:5];fline=actor.cpp:22;event=flush_writing;size=319568;count=1;
2024-06-27T20:49:35.889327Z node 1 :TX_COLUMNSHARD DEBUG: Write (record) into pathId 3 at tablet 72075186224037888
2024-06-27T20:49:35.889689Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 646360 in 1 records, committed: 0 in 0 records at tablet 72075186224037888
2024-06-27T20:49:35.889701Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager on execute at tablet 72075186224037888 Save Batch GenStep: 1:1 Blob count: 1
2024-06-27T20:49:35.890175Z node 1 :TX_COLUMNSHARD DEBUG: Write (record) into pathId 3 at tablet 72075186224037889
2024-06-27T20:49:35.890278Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 644032 in 1 records, committed: 0 in 0 records at tablet 72075186224037889
2024-06-27T20:49:35.890285Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager on execute at tablet 72075186224037889 Save Batch GenStep: 1:1 Blob count: 1
2024-06-27T20:49:35.890848Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037888 Save Batch GenStep: 1:1 Blob count: 1
2024-06-27T20:49:35.890858Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=1;
2024-06-27T20:49:35.891343Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037889 Save Batch GenStep: 1:1 Blob count: 1
2024-06-27T20:49:35.891353Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=1;
2024-06-27T20:49:35.891584Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;tx_id=281474976715660;this=77178324931200;method=TTxController::StartProposeOnExecute;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;fline=tx_controller.cpp:292;event=start;
2024-06-27T20:49:35.891610Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;tx_id=281474976715660;this=77178324931200;method=TTxController::StartProposeOnExecute;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;fline=tx_controller.cpp:319;event=registered;
2024-06-27T20:49:35.891638Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;tx_id=281474976715660;this=77178324950880;method=TTxController::StartProposeOnExecute;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;fline=tx_controller.cpp:292;event=start;
2024-06-27T20:49:35.891651Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;tx_id=281474976715660;this=77178324950880;method=TTxController::StartProposeOnExecute;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;tx_info=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;fline=tx_controller.cpp:319;event=registered;
2024-06-27T20:49:35.892312Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;request_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;this=77178324931200;op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;int_op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;fline=columnshard__propose_transaction.cpp:94;event=actual tx operator;
2024-06-27T20:49:35.892322Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;request_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;this=77178324931200;op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;int_op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];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:7385288074657051877:8353];cookie=0;
2024-06-27T20:49:35.892355Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;request_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;this=77178324950880;op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;int_op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;fline=columnshard__propose_transaction.cpp:94;event=actual tx operator;
2024-06-27T20:49:35.892362Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;request_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;this=77178324950880;op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];cookie=0;int_op_tx=281474976715660:TX_KIND_COMMIT;min=0;max=18446744073709551615;plan=0;src=[1:7385288074657051877:8353];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:7385288074657051877:8353];cookie=0;
2024-06-27T20:49:35.892630Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719521375936 at tablet 72075186224037888, mediator 72057594046382081
2024-06-27T20:49:35.892640Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[7] execute at tablet 72075186224037888
2024-06-27T20:49:35.892655Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037888;
2024-06-27T20:49:35.892694Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 646360 in 1 records at tablet 72075186224037888
2024-06-27T20:49:35.892706Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719521375936 at tablet 72075186224037889, mediator 72057594046382081
2024-06-27T20:49:35.892708Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[7] execute at tablet 72075186224037889
2024-06-27T20:49:35.892717Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037889;
2024-06-27T20:49:35.892740Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 644032 in 1 records at tablet 72075186224037889
2024-06-27T20:49:35.893346Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[7] complete at tablet 72075186224037888
2024-06-27T20:49:35.893377Z 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:49:35.893393Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;fline=manager.cpp:9;event=lock;process_id=CS::INDEXATION::18f6c2b6-53309948-bd3b301e-ea0b0cbe;
2024-06-27T20:49:35.893402Z 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:49:35.893416Z 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=18f6c2b6-53309948-bd3b301e-ea0b0cbe;
2024-06-27T20:49:35.893540Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;fline=columnshard_impl.cpp:608;event=start_changes;type=CS::INDEXATION;task_id=18f6c2b6-53309948-bd3b301e-ea0b0cbe;
2024-06-27T20:49:35.893596Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051643:10];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=646162;external_task_id=18f6c2b6-53309948-bd3b301e-ea0b0cbe;type=CS::INDEXATION;priority=0;;
2024-06-27T20:49:35.893690Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051643:10];fline=actor.cpp:29;event=result_resources;task_id=1;task=cpu=0;mem=646162;external_task_id=18f6c2b6-53309948-bd3b301e-ea0b0cbe;type=CS::INDEXATION;priority=0;;
2024-06-27T20:49:35.893698Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051643:10];fline=task.cpp:9;event=resource_allocated;external_task_id=18f6c2b6-53309948-bd3b301e-ea0b0cbe;mem=646162;cpu=0;
2024-06-27T20:49:35.893728Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051643:10];fline=task.cpp:40;event=allocate_resources;external_task_id=18f6c2b6-53309948-bd3b301e-ea0b0cbe;task_id=1;mem=646162;cpu=0;
2024-06-27T20:49:35.893748Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=18f6c2b6-53309948-bd3b301e-ea0b0cbe;fline=task.cpp:110;event=OnDataReady;task=agents_waiting=0;additional_info=();;external_task_id=18f6c2b6-53309948-bd3b301e-ea0b0cbe;
2024-06-27T20:49:35.893761Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=18f6c2b6-53309948-bd3b301e-ea0b0cbe;fline=actor.cpp:48;task=agents_waiting=0;additional_info=();;
2024-06-27T20:49:35.893855Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[7] complete at tablet 72075186224037889
2024-06-27T20:49:35.893896Z 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:49:35.893914Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;fline=manager.cpp:9;event=lock;process_id=CS::INDEXATION::57b6a729-27a23475-cb9df64e-730776e;
2024-06-27T20:49:35.893922Z 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:49:35.893935Z 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=57b6a729-27a23475-cb9df64e-730776e;
2024-06-27T20:49:35.893948Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;fline=columnshard_impl.cpp:608;event=start_changes;type=CS::INDEXATION;task_id=57b6a729-27a23475-cb9df64e-730776e;
2024-06-27T20:49:35.895704Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051645:5];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=643840;external_task_id=57b6a729-27a23475-cb9df64e-730776e;type=CS::INDEXATION;priority=0;;
2024-06-27T20:49:35.895767Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051645:5];fline=actor.cpp:29;event=result_resources;task_id=2;task=cpu=0;mem=643840;external_task_id=57b6a729-27a23475-cb9df64e-730776e;type=CS::INDEXATION;priority=0;;
2024-06-27T20:49:35.895788Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051645:5];fline=task.cpp:9;event=resource_allocated;external_task_id=57b6a729-27a23475-cb9df64e-730776e;mem=643840;cpu=0;
2024-06-27T20:49:35.895797Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051645:5];fline=task.cpp:40;event=allocate_resources;external_task_id=57b6a729-27a23475-cb9df64e-730776e;task_id=2;mem=643840;cpu=0;
2024-06-27T20:49:35.895811Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=57b6a729-27a23475-cb9df64e-730776e;fline=task.cpp:110;event=OnDataReady;task=agents_waiting=0;additional_info=();;external_task_id=57b6a729-27a23475-cb9df64e-730776e;
2024-06-27T20:49:35.895820Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=57b6a729-27a23475-cb9df64e-730776e;fline=actor.cpp:48;task=agents_waiting=0;additional_info=();;
2024-06-27T20:49:35.931049Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard__write_index.cpp:50;event=TEvWriteIndex;count=1;
2024-06-27T20:49:35.933260Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard__write_index.cpp:50;event=TEvWriteIndex;count=1;
2024-06-27T20:49:35.933337Z node 1 :TX_COLUMNSHARD DEBUG: WriteIndex at tablet 72075186224037888
2024-06-27T20:49:35.933387Z node 1 :TX_COLUMNSHARD DEBUG: TxWriteIndex[9] (CS::INDEXATION) apply at tablet 72075186224037888
2024-06-27T20:49:35.933553Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager on execute at tablet 72075186224037888 Save Batch GenStep: 1:2 Blob count: 1
2024-06-27T20:49:35.933572Z 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:49:35.933577Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;external_task_id=18f6c2b6-53309948-bd3b301e-ea0b0cbe;fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037888;
2024-06-27T20:49:35.933630Z node 1 :TX_COLUMNSHARD DEBUG: WriteIndex at tablet 72075186224037889
2024-06-27T20:49:35.933656Z node 1 :TX_COLUMNSHARD DEBUG: TxWriteIndex[9] (CS::INDEXATION) apply at tablet 72075186224037889
2024-06-27T20:49:35.933748Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager on execute at tablet 72075186224037889 Save Batch GenStep: 1:2 Blob count: 1
2024-06-27T20:49:35.933764Z 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:49:35.933767Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;external_task_id=57b6a729-27a23475-cb9df64e-730776e;fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037889;
2024-06-27T20:49:35.934908Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=abstract.cpp:45;event=WriteIndexComplete;type=CS::INDEXATION;success=1;
2024-06-27T20:49:35.934987Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 0 in 0 records at tablet 72075186224037888
2024-06-27T20:49:35.934997Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=manager.cpp:14;event=unlock;process_id=CS::INDEXATION::18f6c2b6-53309948-bd3b301e-ea0b0cbe;
2024-06-27T20:49:35.935015Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=0;
2024-06-27T20:49:35.935024Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:35.935026Z node 1 :TX_COLUMNSHARD DEBUG: Create periodic stats pipe to 72057594046644480 at tablet 72075186224037888
2024-06-27T20:49:35.935047Z node 1 :TX_COLUMNSHARD DEBUG: There are stats for 1 tables
2024-06-27T20:49:35.935071Z 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:49:35.935077Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:49:35.935081Z 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:49:35.935083Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888
2024-06-27T20:49:35.935086Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888
2024-06-27T20:49:35.935089Z 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:49:35.935095Z 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:49:35.935100Z 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:49:35.935103Z 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:49:35.935106Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:49:35.935117Z 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:49:35.935167Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037888 Delete Blob DS:2181038080:[72075186224037888:1:1:3:0:646360:0]
2024-06-27T20:49:35.935176Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037888 Save Batch GenStep: 1:2 Blob count: 1
2024-06-27T20:49:35.935180Z 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:49:35.935215Z 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:49:35.935274Z node 1 :TX_COLUMNSHARD DEBUG: fline=task.cpp:21;event=free_resources;task_id=1;external_task_id=18f6c2b6-53309948-bd3b301e-ea0b0cbe;mem=646162;cpu=0;
2024-06-27T20:49:35.935346Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=abstract.cpp:45;event=WriteIndexComplete;type=CS::INDEXATION;success=1;
2024-06-27T20:49:35.935376Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 0 in 0 records at tablet 72075186224037889
2024-06-27T20:49:35.935385Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=manager.cpp:14;event=unlock;process_id=CS::INDEXATION::57b6a729-27a23475-cb9df64e-730776e;
2024-06-27T20:49:35.935389Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=0;
2024-06-27T20:49:35.935392Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:35.935394Z node 1 :TX_COLUMNSHARD DEBUG: Create periodic stats pipe to 72057594046644480 at tablet 72075186224037889
2024-06-27T20:49:35.935400Z node 1 :TX_COLUMNSHARD DEBUG: There are stats for 1 tables
2024-06-27T20:49:35.935408Z 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:49:35.935412Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:49:35.935414Z 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:49:35.935416Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889
2024-06-27T20:49:35.935417Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889
2024-06-27T20:49:35.935420Z 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:49:35.935423Z 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:49:35.935426Z 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:49:35.935429Z 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:49:35.935432Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:49:35.935439Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
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:49:35.935467Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037889 Delete Blob DS:2181038080:[72075186224037889:1:1:3:0:644032:0]
2024-06-27T20:49:35.935476Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037889 Save Batch GenStep: 1:2 Blob count: 1
2024-06-27T20:49:35.935478Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=1;
2024-06-27T20:49:35.935502Z 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:49:35.935807Z node 1 :TX_COLUMNSHARD DEBUG: fline=task.cpp:21;event=free_resources;task_id=2;external_task_id=57b6a729-27a23475-cb9df64e-730776e;mem=643840;cpu=0;
2024-06-27T20:49:35.936110Z node 1 :TX_COLUMNSHARD DEBUG: Connected to 72057594046644480 at tablet 72075186224037888
2024-06-27T20:49:35.936121Z node 1 :TX_COLUMNSHARD DEBUG: Connected to 72057594046644480 at tablet 72075186224037889
2024-06-27T20:49:35.987903Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction
2024-06-27T20:49:35.987966Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction
2024-06-27T20:49:35.991992Z node 1 :TX_COLUMNSHARD DEBUG: EvScan txId: 281474976715662 scanId: 0 version: {1719521376000:max} readable: {1719521376034:max} at tablet 72075186224037889
2024-06-27T20:49:35.992016Z node 1 :TX_COLUMNSHARD DEBUG: TTxScan prepare txId: 281474976715662 scanId: 0 at tablet 72075186224037889
2024-06-27T20:49:35.992036Z node 1 :TX_COLUMNSHARD DEBUG: EvScan txId: 281474976715662 scanId: 0 version: {1719521376000:max} readable: {1719521376034:max} at tablet 72075186224037888
2024-06-27T20:49:35.992049Z node 1 :TX_COLUMNSHARD DEBUG: TTxScan prepare txId: 281474976715662 scanId: 0 at tablet 72075186224037888
2024-06-27T20:49:35.992085Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];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:49:35.992107Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643: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:49:35.997423Z 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:49:35.997522Z 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:49:36.000123Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051931:4331];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=681224;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:49:36.000241Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051931:4331];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:49:36.000249Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051931:4331];fline=task.cpp:9;event=resource_allocated;external_task_id=;mem=681224;cpu=0;
2024-06-27T20:49:36.000254Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051931:4331];fline=task.cpp:40;event=allocate_resources;external_task_id=;task_id=3;mem=681224;cpu=0;
2024-06-27T20:49:36.000258Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051932:4352];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=678776;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:49:36.000339Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051932:4352];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:49:36.000363Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051932:4352];fline=task.cpp:9;event=resource_allocated;external_task_id=;mem=678776;cpu=0;
2024-06-27T20:49:36.000366Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051932:4352];fline=task.cpp:40;event=allocate_resources;external_task_id=;task_id=4;mem=678776;cpu=0;
2024-06-27T20:49:36.001041Z node 1 :TX_COLUMNSHARD DEBUG: SelfId=[1:7385288074657051931:4331];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:49:36.001041Z node 1 :TX_COLUMNSHARD DEBUG: SelfId=[1:7385288074657051932:4352];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:49:36.001237Z node 1 :TX_COLUMNSHARD DEBUG: Finished read cookie: 2 at tablet 72075186224037888
2024-06-27T20:49:36.001253Z node 1 :TX_COLUMNSHARD DEBUG: Finished read cookie: 2 at tablet 72075186224037889
2024-06-27T20:49:36.002387Z node 1 :KQP_RESOURCE_MANAGER WARN: KqpSnapshotManager: discarding snapshot; our snapshot: [step: 1719521376000, txId: 18446744073709551615] shutting down
2024-06-27T20:49:36.074483Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051645:5];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:36.074498Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051643:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:36.574735Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051645:5];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:36.574739Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051643:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:36.579868Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037889;
2024-06-27T20:49:36.579894Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:36.579962Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521376034 at tablet 72075186224037889
2024-06-27T20:49:36.579976Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:49:36.579983Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:36.579993Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:49:36.580003Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:49:36.580006Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:49:36.580008Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889
2024-06-27T20:49:36.580009Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889
2024-06-27T20:49:36.580013Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:49:36.580022Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:49:36.580028Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:36.580031Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:36.580035Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:49:36.580046Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:49:36.580354Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;
2024-06-27T20:49:36.580377Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:36.580389Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521376034 at tablet 72075186224037888
2024-06-27T20:49:36.580397Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:49:36.580400Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:36.580405Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:49:36.580416Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:49:36.580419Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:49:36.580420Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888
2024-06-27T20:49:36.580422Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888
2024-06-27T20:49:36.580425Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:49:36.580429Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643: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:49:36.580432Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:36.580434Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:36.580439Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:49:36.580446Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
SHARING: 72075186224037889->72075186224037888
2024-06-27T20:49:37.003161Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard_impl.cpp:890;process=BlobsSharing;event=TEvProposeFromInitiator;
2024-06-27T20:49:37.003901Z 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=c41abcc8-34c6-11ef-8562-b53c2928ead0;
2024-06-27T20:49:37.081526Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051643:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:37.081527Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051645:5];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:37.580316Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037889;
2024-06-27T20:49:37.580338Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:37.580359Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521377000 at tablet 72075186224037889
2024-06-27T20:49:37.580367Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:49:37.580373Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:37.580384Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:49:37.580411Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:49:37.580420Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:49:37.580421Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889
2024-06-27T20:49:37.580423Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889
2024-06-27T20:49:37.580428Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:49:37.580433Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:49:37.580439Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:37.580446Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:37.580449Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:49:37.580467Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:49:37.580816Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;
2024-06-27T20:49:37.580830Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:37.580858Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521377000 at tablet 72075186224037888
2024-06-27T20:49:37.580871Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:49:37.580876Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:37.580885Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:49:37.580901Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:49:37.580904Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:49:37.580906Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888
2024-06-27T20:49:37.580908Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888
2024-06-27T20:49:37.580911Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:49:37.580917Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643: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:49:37.580921Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:37.580925Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:37.580928Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:49:37.580940Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:49:37.581828Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051643:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:37.581841Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051645:5];fline=actor.cpp:33;event=skip_flush_writing;
WAIT_PROPOSING...
2024-06-27T20:49:38.005587Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard_impl.cpp:913;process=BlobsSharing;event=TEvConfirmFromInitiator;
2024-06-27T20:49:38.007170Z 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=c41abcc8-34c6-11ef-8562-b53c2928ead0;
2024-06-27T20:49:38.082076Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051643:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:38.082075Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051645:5];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:38.580770Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037889;
2024-06-27T20:49:38.580792Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:38.580813Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521378000 at tablet 72075186224037889
2024-06-27T20:49:38.580824Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:49:38.580830Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:38.580840Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:49:38.580857Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:49:38.580861Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:49:38.580862Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889
2024-06-27T20:49:38.580864Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889
2024-06-27T20:49:38.580870Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:49:38.580878Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:49:38.580885Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:38.580888Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:38.580893Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:49:38.580911Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:49:38.581253Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;
2024-06-27T20:49:38.581266Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:38.581282Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521378000 at tablet 72075186224037888
2024-06-27T20:49:38.581286Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:49:38.581289Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:38.581302Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;sessions=start;tablet_id=72075186224037888;info=dest_proto;fline=manager.cpp:9;event=lock;process_id=sharing_session:c41abcc8-34c6-11ef-8562-b53c2928ead0;
2024-06-27T20:49:38.581307Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;sessions=start;tablet_id=72075186224037888;info=dest_proto;fline=common.cpp:17;info=Start;
2024-06-27T20:49:38.581347Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:49:38.581368Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:49:38.581375Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:49:38.581376Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888
2024-06-27T20:49:38.581377Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888
2024-06-27T20:49:38.581381Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:49:38.581385Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643: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:49:38.581388Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:38.581390Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:38.581393Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:49:38.581402Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:49:38.581414Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard_impl.cpp:929;process=BlobsSharing;event=TEvStartToSource;
2024-06-27T20:49:38.582299Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051645:5];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:38.582324Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051643:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:38.582482Z 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;
WAIT_CONFIRMED...
2024-06-27T20:49:39.082563Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051645:5];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:39.082586Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051643:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:39.581191Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037889;
2024-06-27T20:49:39.581216Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:39.581237Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521379000 at tablet 72075186224037889
2024-06-27T20:49:39.581242Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:49:39.581249Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:39.581265Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;sessions=start;tablet_id=72075186224037889;info=source_proto;fline=manager.cpp:9;event=lock;process_id=sharing_session:c41abcc8-34c6-11ef-8562-b53c2928ead0;
2024-06-27T20:49:39.581269Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;sessions=start;tablet_id=72075186224037889;info=source_proto;fline=common.cpp:17;info=Start;
2024-06-27T20:49:39.581470Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:49:39.581492Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:49:39.581495Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:49:39.581496Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889
2024-06-27T20:49:39.581498Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889
2024-06-27T20:49:39.581502Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:49:39.581508Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:406;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0;
2024-06-27T20:49:39.581513Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:39.581517Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:39.581521Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:49:39.581550Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard_impl.cpp:944;process=BlobsSharing;event=TEvSendDataFromSource;
2024-06-27T20:49:39.581555Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet_id=72075186224037889;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:49:39.581647Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard_impl.cpp:964;event=on_received_data;
2024-06-27T20:49:39.581871Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard_impl.cpp:1038;process=BlobsSharing;event=TEvApplyLinksModification;info=InitiatorTabletId: 72075186224037889
SessionId: "c41abcc8-34c6-11ef-8562-b53c2928ead0"
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:49:39.581919Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard_impl.cpp:1038;process=BlobsSharing;event=TEvApplyLinksModification;info=InitiatorTabletId: 72075186224037889
SessionId: "c41abcc8-34c6-11ef-8562-b53c2928ead0"
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:49:39.581969Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard.cpp:175;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888;
2024-06-27T20:49:39.581990Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:39.582061Z node 1 :TX_COLUMNSHARD DEBUG: Notified by mediator time cast with PlanStep# 1719521379000 at tablet 72075186224037888
2024-06-27T20:49:39.582074Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:509;event=EnqueueBackgroundActivities;periodic=1;
2024-06-27T20:49:39.582079Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats.
2024-06-27T20:49:39.582087Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:685;event=start_indexation_tasks;insert_overload_size=0;
2024-06-27T20:49:39.582097Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=storage.cpp:30;event=no_granules;
2024-06-27T20:49:39.582106Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:298;event=no granules for start compaction;
2024-06-27T20:49:39.582108Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888
2024-06-27T20:49:39.582110Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888
2024-06-27T20:49:39.582114Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:335;event=StartCleanup;portions_count=0;
2024-06-27T20:49:39.582119Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643: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:49:39.582123Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:795;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:39.582126Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:818;background=cleanup;skip_reason=no_changes;
2024-06-27T20:49:39.582129Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=column_engine_logs.cpp:419;event=StartTtl;external=0;
2024-06-27T20:49:39.582141Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet_id=72075186224037888;fline=columnshard_impl.cpp:757;background=ttl;skip_reason=no_changes;
2024-06-27T20:49:39.582710Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051643:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:39.582717Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051645:5];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:39.582888Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard_impl.cpp:1052;process=BlobsSharing;event=TEvApplyLinksModificationFinished;
2024-06-27T20:49:39.582910Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=cursor.h:60;event=SourceAckData;pack=1;pack_ack=0;links_ready=1;links_waiting=2;
2024-06-27T20:49:39.582913Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard_impl.cpp:1064;event=on_change_links_finish;tablet_id=72075186224037889;
2024-06-27T20:49:39.582943Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard_impl.cpp:970;process=BlobsSharing;event=TEvAckDataToSource;
2024-06-27T20:49:39.582947Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=cursor.h:50;event=SourceAckData;pack=1;pack_ack=1;links_ready=1;links_waiting=2;
2024-06-27T20:49:39.582950Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard_impl.cpp:981;event=on_ack_data;
2024-06-27T20:49:39.582962Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard_impl.cpp:1052;process=BlobsSharing;event=TEvApplyLinksModificationFinished;
2024-06-27T20:49:39.582965Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=cursor.h:60;event=SourceAckData;pack=1;pack_ack=1;links_ready=2;links_waiting=2;
2024-06-27T20:49:39.582969Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard_impl.cpp:1064;event=on_change_links_finish;tablet_id=72075186224037888;
2024-06-27T20:49:39.583808Z 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:c41abcc8-34c6-11ef-8562-b53c2928ead0;
2024-06-27T20:49:39.583841Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard_impl.cpp:1004;process=BlobsSharing;event=TEvFinishedFromSource;
2024-06-27T20:49:39.583855Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=columnshard_impl.cpp:1015;event=on_finished_data;
__DEFAULT
    DS:2181038080:[72075186224037889:1:2:4:0:168096:0]
        O: 72075186224037889
        S: 72075186224037888,72075186224037889
2024-06-27T20:49:39.584901Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard_impl.cpp:987;process=BlobsSharing;event=TEvAckFinishToSource;
2024-06-27T20:49:39.584913Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=columnshard_impl.cpp:998;event=on_ack_finish;
2024-06-27T20:49:39.584922Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_no=15;tx_info=;fline=manager.cpp:14;event=unlock;process_id=sharing_session:c41abcc8-34c6-11ef-8562-b53c2928ead0;
2024-06-27T20:49:39.584930Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;tx_no=15;tx_info=;fline=blobs_sharing_ut.cpp:54;event=sharing_finished;session_id=c41abcc8-34c6-11ef-8562-b53c2928ead0;
WAIT_FINISHED...
FALLBACK_ACTOR_LOGGING;priority=WARN;component=332;fline=controller.cpp:117;reason=non_trivial;
2024-06-27T20:49:40.007551Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction
2024-06-27T20:49:40.007621Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction
2024-06-27T20:49:40.008380Z node 1 :TX_COLUMNSHARD DEBUG: EvScan txId: 281474976715664 scanId: 0 version: {1719521380000:max} readable: {1719521380052:max} at tablet 72075186224037888
2024-06-27T20:49:40.008381Z node 1 :TX_COLUMNSHARD DEBUG: EvScan txId: 281474976715664 scanId: 0 version: {1719521380000:max} readable: {1719521380052:max} at tablet 72075186224037889
2024-06-27T20:49:40.008398Z node 1 :TX_COLUMNSHARD DEBUG: TTxScan prepare txId: 281474976715664 scanId: 0 at tablet 72075186224037889
2024-06-27T20:49:40.008403Z node 1 :TX_COLUMNSHARD DEBUG: TTxScan prepare txId: 281474976715664 scanId: 0 at tablet 72075186224037888
2024-06-27T20:49:40.008495Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643: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:49:40.008500Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];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:49:40.008624Z 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:49:40.008656Z 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:49:40.010933Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288096131888521:4374];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=678776;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:49:40.011058Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288096131888521:4374];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:49:40.011083Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288096131888521:4374];fline=task.cpp:9;event=resource_allocated;external_task_id=;mem=678776;cpu=0;
2024-06-27T20:49:40.011087Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288096131888521:4374];fline=task.cpp:40;event=allocate_resources;external_task_id=;task_id=5;mem=678776;cpu=0;
2024-06-27T20:49:40.011305Z node 1 :TX_COLUMNSHARD DEBUG: SelfId=[1:7385288096131888521:4374];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:49:40.011563Z node 1 :TX_COLUMNSHARD DEBUG: Finished read cookie: 3 at tablet 72075186224037889
2024-06-27T20:49:40.013225Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288096131888524:4361];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=961728;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:49:40.013245Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288096131888524:4361];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=1920000;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:49:40.013249Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288096131888524:4361];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=958272;external_task_id=;type=CS::SCAN_READ;priority=0;;
2024-06-27T20:49:40.013288Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288096131888524:4361];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:49:40.013292Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288096131888524:4361];fline=task.cpp:9;event=resource_allocated;external_task_id=;mem=961728;cpu=0;
2024-06-27T20:49:40.013294Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288096131888524:4361];fline=task.cpp:40;event=allocate_resources;external_task_id=;task_id=6;mem=961728;cpu=0;
2024-06-27T20:49:40.013305Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288096131888524:4361];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:49:40.013309Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288096131888524:4361];fline=task.cpp:9;event=resource_allocated;external_task_id=;mem=1920000;cpu=0;
2024-06-27T20:49:40.013311Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288096131888524:4361];fline=task.cpp:40;event=allocate_resources;external_task_id=;task_id=7;mem=1920000;cpu=0;
2024-06-27T20:49:40.013317Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288096131888524:4361];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:49:40.013318Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288096131888524:4361];fline=task.cpp:9;event=resource_allocated;external_task_id=;mem=958272;cpu=0;
2024-06-27T20:49:40.013320Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288096131888524:4361];fline=task.cpp:40;event=allocate_resources;external_task_id=;task_id=8;mem=958272;cpu=0;
2024-06-27T20:49:40.013466Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=;fline=actor.cpp:48;task=agents_waiting=1;additional_info=();;
2024-06-27T20:49:40.013478Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=;fline=actor.cpp:48;task=agents_waiting=1;additional_info=();;
2024-06-27T20:49:40.013627Z node 1 :TX_COLUMNSHARD DEBUG: fline=task.cpp:110;event=OnDataReady;task=agents_waiting=0;additional_info=();;external_task_id=;
2024-06-27T20:49:40.013886Z node 1 :TX_COLUMNSHARD DEBUG: fline=task.cpp:110;event=OnDataReady;task=agents_waiting=0;additional_info=();;external_task_id=;
2024-06-27T20:49:40.014990Z node 1 :TX_COLUMNSHARD DEBUG: SelfId=[1:7385288096131888524:4361];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:49:40.047016Z node 1 :TX_COLUMNSHARD DEBUG: SelfId=[1:7385288096131888524:4361];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:49:40.047065Z node 1 :TX_COLUMNSHARD DEBUG: SelfId=[1:7385288096131888524:4361];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:49:40.047500Z node 1 :TX_COLUMNSHARD DEBUG: Finished read cookie: 3 at tablet 72075186224037888
2024-06-27T20:49:40.047530Z node 1 :KQP_RESOURCE_MANAGER WARN: KqpSnapshotManager: discarding snapshot; our snapshot: [step: 1719521380000, txId: 18446744073709551615] shutting down
FALLBACK_ACTOR_LOGGING;priority=TRACE;component=2100;fline=native.cpp:67;event=parsing;size=640144;columns=1;
FALLBACK_ACTOR_LOGGING;priority=DEBUG;component=2100;fline=native.cpp:101;event=serialize;size=640144;columns=1;
2024-06-27T20:49:40.054654Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=column_engine.cpp:22;total=202797998080;kff=0.3;
2024-06-27T20:49:40.054670Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=column_engine.cpp:22;total=202797998080;kff=0.3;
2024-06-27T20:49:40.054733Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];fline=column_engine.cpp:22;total=202797998080;kff=0.3;
2024-06-27T20:49:40.054734Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];fline=column_engine.cpp:22;total=202797998080;kff=0.3;
2024-06-27T20:49:40.054770Z 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:49:40.054772Z 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:49:40.168427Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385288074657051645:5];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:40.168741Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385288074657051643:10];fline=actor.cpp:33;event=skip_flush_writing;
2024-06-27T20:49:40.196586Z node 1 :TX_COLUMNSHARD_SCAN WARN: tablet_id=72075186224037889;self_id=[1:7385288074657051645:5];tablet=72075186224037889;fline=tx_internal_scan.cpp:54;event=TTxScan failed;reason=no metadata;
2024-06-27T20:49:40.196675Z node 1 :TX_COLUMNSHARD_SCAN WARN: tablet_id=72075186224037888;self_id=[1:7385288074657051643:10];tablet=72075186224037888;fline=tx_internal_scan.cpp:54;event=TTxScan failed;reason=no metadata;
VERIFY failed (2024-06-27T20:49:40.197977Z): tablet_id=72075186224037889;verification=false;fline=actor.h:66;
  ydb/library/actors/core/log.cpp:744
  ~TVerifyFormattedRecordWriter(): requirement false failed
0. /-S/util/system/yassert.cpp:83: NPrivate::InternalPanicImpl(int, char const*, char const*, int, int, int, TBasicStringBuf<char, std::__y1::char_traits<char>>, char const*, unsigned long) @ 0x11BF133C
1. /-S/util/system/yassert.cpp:55: NPrivate::Panic(NPrivate::TStaticBuf const&, int, char const*, char const*, char const*, ...) @ 0x11BE9086
2. /-S/ydb/library/actors/core/log.cpp:744: NActors::TVerifyFormattedRecordWriter::~TVerifyFormattedRecordWriter() @ 0x12AEAEF3
3. /-S/ydb/core/tx/columnshard/data_reader/actor.h:66: NKikimr::NOlap::NDataReader::TActor::HandleExecute(TAutoPtr<NActors::TEventHandle<NKikimr::NKqp::TEvKqpCompute::TEvScanError>, TDelete>&) @ 0x1CEB9AB8
4. /-S/ydb/core/tx/columnshard/data_reader/actor.h:82: NKikimr::NOlap::NDataReader::TActor::StateFunc(TAutoPtr<NActors::IEventHandle, TDelete>&) @ 0x1CEB8322
5. /-S/ydb/library/actors/core/executor_thread.cpp:251: NActors::TGenericExecutorThread::TProcessingResult NActors::TGenericExecutorThread::Execute<NActors::TMailboxTable::THTSwapMailbox>(NActors::TMailboxTable::THTSwapMailbox*, unsigned int, bool) @ 0x12ACAAB7
6. /-S/ydb/library/actors/core/executor_thread.cpp:439: NActors::TGenericExecutorThread::ProcessExecutorPool(NActors::IExecutorPool*)::$_0::operator()(unsigned int, bool) const @ 0x12AC2211
7. /-S/ydb/library/actors/core/executor_thread.cpp:492: NActors::TGenericExecutorThread::ProcessExecutorPool(NActors::IExecutorPool*) @ 0x12AC1C09
8. /-S/ydb/library/actors/core/executor_thread.cpp:523: NActors::TExecutorThread::ThreadProc() @ 0x12AC2AAF
9. /-S/util/system/thread.cpp:244: (anonymous namespace)::TPosixThread::ThreadProxy(void*) @ 0x11BF6B4E
10. ??:0: ?? @ 0x7FDD7A00DAC2
11. ??:0: ?? @ 0x7FDD7A09F84F