Trying to start YDB, gRPC: 26665, MsgBus: 2590 No Keys in KeyConfig! Encrypted group DsProxies will not start 2024-06-28T14:48:18.774444Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction 2024-06-28T14:48:18.774597Z node 1 :METADATA_PROVIDER WARN: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[1:7385566057000527416:4098];send_to=[0:7307199536658146131:7762515]; 2024-06-28T14:48:18.774607Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction 2024-06-28T14:48:18.774682Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction 2024-06-28T14:48:18.774778Z 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; NMsgBusProxy registered on Port 2590 GrpcPort 0 test_client.cpp: SetPath # /home/runner/.ya/build/build_root/v5om/00232b/r3tmp/tmpS4zEAK/pdisk_1.dat 2024-06-28T14:48:18.846018Z node 1 :IMPORT WARN: Table profiles were not loaded TServer::EnableGrpc on GrpcPort 26665, node 1 2024-06-28T14:48:18.865664Z node 1 :NET_CLASSIFIER WARN: distributable config is empty, broken or outdated, will use file: (empty maybe) 2024-06-28T14:48:18.865675Z node 1 :NET_CLASSIFIER WARN: will try to initialize from file: (empty maybe) 2024-06-28T14:48:18.865677Z node 1 :NET_CLASSIFIER WARN: failed to initialize from file: (empty maybe) 2024-06-28T14:48:18.865712Z node 1 :NET_CLASSIFIER ERROR: got bad distributable configuration 2024-06-28T14:48:18.870547Z node 1 :HIVE WARN: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Unknown -> Disconnected 2024-06-28T14:48:18.870568Z node 1 :HIVE WARN: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Disconnected -> Connecting TClient is connected to server localhost:2590 2024-06-28T14:48:18.876015Z node 1 :HIVE WARN: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Connecting -> Connected TClient is connected to server localhost:2590 WaitRootIsUp 'Root'... TClient::Ls request: Root TClient::Ls response: Status: 1 StatusCode: SUCCESS SchemeStatus: 0 PathDescription { Self { Name: "Root" PathId: 1 SchemeshardId: 72057594046644480 PathType: EPathTypeDir CreateFinished: true CreateTxId: 1 CreateStep: 0 ParentPathId: 1 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "" EffectiveACL: "" PathVersion: 2 PathSubType: EPathSubTypeEmpty Version { GeneralVersion: 2 ACLVersion: 0 EffectiveACLVersion: 0 UserAttrsVersion: 1 ChildrenVersion: 1 SubDomainVersion: 0 SecurityStateVersion: 0 } } Children { Name: ".sys" PathId: 18446744073709551615 SchemeshardId: 72057594046644480 PathType: EPathTypeDir CreateFinished: true CreateTxId: 0 CreateStep: 0 ParentPathId: 18446744073709551615 } DomainDescription { SchemeShardId_Depricated: 72057594046644480 PathId_Depricated: 1 ProcessingParams { Version: 0 PlanResolution: 7 Coo... (TRUNCATED) WaitRootIsUp 'Root' success. waiting... Status: 53 TxId: 281474976715658 SchemeShardStatus: 1 SchemeShardTabletId: 72057594046644480 PathId: 2 2024-06-28T14:48:18.949630Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=columnshard.cpp:62;event=initialize_shard;step=OnActivateExecutor; 2024-06-28T14:48:18.953714Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=columnshard.cpp:62;event=initialize_shard;step=OnActivateExecutor; 2024-06-28T14:48:18.955484Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=columnshard.cpp:78;event=initialize_shard;step=initialize_tiring_finished; 2024-06-28T14:48:18.955516Z node 1 :TX_COLUMNSHARD DEBUG: TxInitSchema.Execute at tablet 72075186224037889 2024-06-28T14:48:18.957046Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=columnshard.cpp:78;event=initialize_shard;step=initialize_tiring_finished; 2024-06-28T14:48:18.957063Z node 1 :TX_COLUMNSHARD DEBUG: TxInitSchema.Execute at tablet 72075186224037888 2024-06-28T14:48:18.957704Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385566057000528042:6];fline=actor.cpp:33;event=skip_flush_writing; 2024-06-28T14:48:18.959610Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385566057000528041:5];fline=actor.cpp:33;event=skip_flush_writing; 2024-06-28T14:48:18.959642Z node 1 :TX_COLUMNSHARD DEBUG: TxInitSchema.Complete at tablet 72075186224037888 2024-06-28T14:48:18.959657Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:265;step=TTxUpdateSchema.Execute_Start;details=normalizers_count=4;current_normalizer_idx=0;current_normalizer=TGranulesNormalizer; 2024-06-28T14:48:18.959682Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=normalizer.cpp:123;normalizer=TGranulesNormalizer;message=0 chunks found; 2024-06-28T14:48:18.959689Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=chunks.cpp:127;normalizer=TChunksNormalizer;message=0 chunks found; 2024-06-28T14:48:18.959719Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:282;step=TTxUpdateSchema.Execute_Finish; 2024-06-28T14:48:18.959727Z node 1 :TX_COLUMNSHARD INFO: fline=columnshard__init.cpp:287;step=TTxUpdateSchema.Complete; 2024-06-28T14:48:18.959734Z node 1 :TX_COLUMNSHARD DEBUG: TTxInit.Execute at tablet 72075186224037888 2024-06-28T14:48:18.959764Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:102;step=TInsertTable::Load_Start; 2024-06-28T14:48:18.959903Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:109;step=TInsertTable::Load_Finish; 2024-06-28T14:48:18.959911Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:114;step=TTxController::Load_Start; 2024-06-28T14:48:18.959917Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:121;step=TTxController::Load_Finish; 2024-06-28T14:48:18.959921Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:126;step=TOperationsManager::Load_Start; 2024-06-28T14:48:18.959932Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:133;step=TOperationsManager::Load_Finish; 2024-06-28T14:48:18.959963Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;event=initialize_shard;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=0; 2024-06-28T14:48:18.959969Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:146;step=TTablesManager::Load_Start; 2024-06-28T14:48:18.959983Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;event=initialize_shard;fline=columnshard__init.cpp:167;step=TTablesManager::Load_Finish; 2024-06-28T14:48:18.960007Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 0 in 0 records at tablet 72075186224037888 2024-06-28T14:48:18.960018Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=columnshard.cpp:43;event=initialize_shard;step=SwitchToWork; 2024-06-28T14:48:18.960021Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=columnshard.cpp:51;event=initialize_shard;step=SignalTabletActive; 2024-06-28T14:48:18.960024Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037888; 2024-06-28T14:48:18.960120Z node 1 :TX_COLUMNSHARD DEBUG: fline=column_engine.cpp:20;total=202798010368;kff=0.3; 2024-06-28T14:48:18.960156Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=columnshard_impl.cpp:519;event=EnqueueBackgroundActivities;periodic=0; 2024-06-28T14:48:18.960159Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:18.960161Z node 1 :TX_COLUMNSHARD DEBUG: Disabled periodic stats at tablet 72075186224037888 2024-06-28T14:48:18.960163Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;fline=columnshard_impl.cpp:526;problem=Background activities cannot be started: no index at tablet; 2024-06-28T14:48:18.960179Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:519;event=EnqueueBackgroundActivities;periodic=0; 2024-06-28T14:48:18.960180Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:18.960181Z node 1 :TX_COLUMNSHARD DEBUG: Disabled periodic stats at tablet 72075186224037888 2024-06-28T14:48:18.960184Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:526;problem=Background activities cannot be started: no index at tablet; 2024-06-28T14:48:18.960190Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=columnshard.cpp:169;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888; 2024-06-28T14:48:18.960192Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:18.960193Z node 1 :TX_COLUMNSHARD DEBUG: Disabled periodic stats at tablet 72075186224037888 2024-06-28T14:48:18.960203Z node 1 :TX_COLUMNSHARD DEBUG: TxInitSchema.Complete at tablet 72075186224037889 2024-06-28T14:48:18.960213Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:265;step=TTxUpdateSchema.Execute_Start;details=normalizers_count=4;current_normalizer_idx=0;current_normalizer=TGranulesNormalizer; 2024-06-28T14:48:18.960227Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=normalizer.cpp:123;normalizer=TGranulesNormalizer;message=0 chunks found; 2024-06-28T14:48:18.960233Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=chunks.cpp:127;normalizer=TChunksNormalizer;message=0 chunks found; 2024-06-28T14:48:18.960260Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:282;step=TTxUpdateSchema.Execute_Finish; 2024-06-28T14:48:18.960265Z node 1 :TX_COLUMNSHARD INFO: fline=columnshard__init.cpp:287;step=TTxUpdateSchema.Complete; 2024-06-28T14:48:18.960270Z node 1 :TX_COLUMNSHARD DEBUG: TTxInit.Execute at tablet 72075186224037889 2024-06-28T14:48:18.960300Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:102;step=TInsertTable::Load_Start; 2024-06-28T14:48:18.960409Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:109;step=TInsertTable::Load_Finish; 2024-06-28T14:48:18.960413Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:114;step=TTxController::Load_Start; 2024-06-28T14:48:18.960418Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:121;step=TTxController::Load_Finish; 2024-06-28T14:48:18.960421Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:126;step=TOperationsManager::Load_Start; 2024-06-28T14:48:18.960428Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:133;step=TOperationsManager::Load_Finish; 2024-06-28T14:48:18.960452Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;event=initialize_shard;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=0; 2024-06-28T14:48:18.960456Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:146;step=TTablesManager::Load_Start; 2024-06-28T14:48:18.960463Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;event=initialize_shard;fline=columnshard__init.cpp:167;step=TTablesManager::Load_Finish; 2024-06-28T14:48:18.960476Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 0 in 0 records at tablet 72075186224037889 2024-06-28T14:48:18.960484Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=columnshard.cpp:43;event=initialize_shard;step=SwitchToWork; 2024-06-28T14:48:18.960487Z node 1 :TX_COLUMNSHARD INFO: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=columnshard.cpp:51;event=initialize_shard;step=SignalTabletActive; 2024-06-28T14:48:18.960489Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037889; 2024-06-28T14:48:18.960538Z node 1 :TX_COLUMNSHARD DEBUG: fline=column_engine.cpp:20;total=202798010368;kff=0.3; 2024-06-28T14:48:18.960571Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=columnshard_impl.cpp:519;event=EnqueueBackgroundActivities;periodic=0; 2024-06-28T14:48:18.960573Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:18.960574Z node 1 :TX_COLUMNSHARD DEBUG: Disabled periodic stats at tablet 72075186224037889 2024-06-28T14:48:18.960576Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;fline=columnshard_impl.cpp:526;problem=Background activities cannot be started: no index at tablet; 2024-06-28T14:48:18.960586Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:519;event=EnqueueBackgroundActivities;periodic=0; 2024-06-28T14:48:18.960588Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:18.960589Z node 1 :TX_COLUMNSHARD DEBUG: Disabled periodic stats at tablet 72075186224037889 2024-06-28T14:48:18.960590Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:526;problem=Background activities cannot be started: no index at tablet; 2024-06-28T14:48:18.960599Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=columnshard.cpp:169;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037889; 2024-06-28T14:48:18.960600Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:18.960601Z node 1 :TX_COLUMNSHARD DEBUG: Disabled periodic stats at tablet 72075186224037889 2024-06-28T14:48:18.960627Z node 1 :TX_COLUMNSHARD DEBUG: fline=columnshard.cpp:70;event=tiering_new_event; 2024-06-28T14:48:18.960632Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=columnshard_impl.cpp:1132;event=OnTieringModified;path_id=NO_VALUE_OPTIONAL; 2024-06-28T14:48:18.960637Z node 1 :TX_COLUMNSHARD DEBUG: fline=columnshard.cpp:70;event=tiering_new_event; 2024-06-28T14:48:18.960640Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=columnshard_impl.cpp:1132;event=OnTieringModified;path_id=NO_VALUE_OPTIONAL; 2024-06-28T14:48:18.993566Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037888 2024-06-28T14:48:18.993608Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037889 2024-06-28T14:48:18.995816Z node 1 :TX_COLUMNSHARD DEBUG: Registered with mediator time cast at tablet 72075186224037888 2024-06-28T14:48:18.995828Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037888 2024-06-28T14:48:18.995833Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719586099042 at tablet 72075186224037888, mediator 72057594046382081 2024-06-28T14:48:18.995838Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[2] execute at tablet 72075186224037888 2024-06-28T14:48:18.995865Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037888; 2024-06-28T14:48:18.995904Z node 1 :TX_COLUMNSHARD DEBUG: TTxNotifyTxCompletion.Execute at tablet 72075186224037888 2024-06-28T14:48:18.995928Z node 1 :TX_COLUMNSHARD DEBUG: Registered with mediator time cast at tablet 72075186224037889 2024-06-28T14:48:18.995930Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037889 2024-06-28T14:48:18.995933Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719586099042 at tablet 72075186224037889, mediator 72057594046382081 2024-06-28T14:48:18.995936Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[2] execute at tablet 72075186224037889 2024-06-28T14:48:18.995949Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037889; 2024-06-28T14:48:18.995970Z node 1 :TX_COLUMNSHARD DEBUG: TTxNotifyTxCompletion.Execute at tablet 72075186224037889 2024-06-28T14:48:18.996513Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[2] complete at tablet 72075186224037888 2024-06-28T14:48:18.996539Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:519;event=EnqueueBackgroundActivities;periodic=0; 2024-06-28T14:48:18.996544Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:18.996546Z node 1 :TX_COLUMNSHARD DEBUG: Create periodic stats pipe to 72057594046644480 at tablet 72075186224037888 2024-06-28T14:48:18.996567Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:526;problem=Background activities cannot be started: no index at tablet; 2024-06-28T14:48:18.996584Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[2] complete at tablet 72075186224037889 2024-06-28T14:48:18.996595Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:519;event=EnqueueBackgroundActivities;periodic=0; 2024-06-28T14:48:18.996597Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:18.996599Z node 1 :TX_COLUMNSHARD DEBUG: Create periodic stats pipe to 72057594046644480 at tablet 72075186224037889 2024-06-28T14:48:18.996603Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:526;problem=Background activities cannot be started: no index at tablet; 2024-06-28T14:48:18.997568Z node 1 :TX_COLUMNSHARD DEBUG: Connected to 72057594046644480 at tablet 72075186224037888 2024-06-28T14:48:18.997575Z node 1 :TX_COLUMNSHARD DEBUG: Connected to 72057594046644480 at tablet 72075186224037889 2024-06-28T14:48:18.997767Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe reset at tablet 72075186224037888 2024-06-28T14:48:18.997815Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe reset at tablet 72075186224037889 Status: 53 TxId: 281474976715659 SchemeShardStatus: 1 SchemeShardTabletId: 72057594046644480 PathId: 3 2024-06-28T14:48:18.999024Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037888 2024-06-28T14:48:18.999104Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037889 2024-06-28T14:48:19.006886Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719586099056 at tablet 72075186224037888, mediator 72057594046382081 2024-06-28T14:48:19.006907Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[4] execute at tablet 72075186224037888 2024-06-28T14:48:19.006928Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037888; 2024-06-28T14:48:19.006958Z node 1 :TX_COLUMNSHARD DEBUG: EnsureTable for pathId: 3 ttl settings: { } at tablet 72075186224037888 2024-06-28T14:48:19.007828Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=execute;fline=column_engine.h:279;event=RegisterTable;path_id=3; 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-28T14:48:19.008246Z node 1 :TX_COLUMNSHARD DEBUG: TTxNotifyTxCompletion.Execute at tablet 72075186224037888 2024-06-28T14:48:19.008269Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719586099056 at tablet 72075186224037889, mediator 72057594046382081 2024-06-28T14:48:19.008278Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[4] execute at tablet 72075186224037889 2024-06-28T14:48:19.008291Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037889; 2024-06-28T14:48:19.008310Z node 1 :TX_COLUMNSHARD DEBUG: EnsureTable for pathId: 3 ttl settings: { } at tablet 72075186224037889 2024-06-28T14:48:19.008831Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=execute;fline=column_engine.h:279;event=RegisterTable;path_id=3; 2024-06-28T14:48:19.008894Z node 1 :TX_COLUMNSHARD DEBUG: TTxNotifyTxCompletion.Execute at tablet 72075186224037889 2024-06-28T14:48:19.009132Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[4] complete at tablet 72075186224037888 2024-06-28T14:48:19.009154Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:519;event=EnqueueBackgroundActivities;periodic=0; 2024-06-28T14:48:19.009158Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:19.009165Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:697;event=start_indexation_tasks;insert_overload_size=0; 2024-06-28T14:48:19.009184Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=storage.cpp:29;event=no_granules; 2024-06-28T14:48:19.009189Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=column_engine_logs.cpp:275;event=no granules for start compaction; 2024-06-28T14:48:19.009191Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888 2024-06-28T14:48:19.009192Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888 2024-06-28T14:48:19.009196Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=column_engine_logs.cpp:316;event=StartCleanup;portions_count=0; 2024-06-28T14:48:19.009202Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=column_engine_logs.cpp:381;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0; 2024-06-28T14:48:19.009206Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:806;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.009209Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:829;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.009212Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=column_engine_logs.cpp:394;event=StartTtl;external=0; 2024-06-28T14:48:19.009217Z node 1 :TX_COLUMNSHARD WARN: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=column_engine_logs.cpp:418;event=StartTtl;skip=not_ready_tiers; 2024-06-28T14:48:19.009221Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:770;background=ttl;skip_reason=no_changes; 2024-06-28T14:48:19.009228Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;storage_id=__MEMORY;tablet_id=72075186224037888;fline=gc_info.h:20;event=extract_for_gc_skip;reason=no_data; 2024-06-28T14:48:19.009230Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;storage_id=__MEMORY;tablet_id=72075186224037888;fline=storage.cpp:37;event=start_gc_skipped;reason=cannot_extract; 2024-06-28T14:48:19.009238Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;storage_id=__DEFAULT;tablet_id=72075186224037888;fline=blob_manager.cpp:282;event=PreparePerGroupGCRequests;gen=1;step=0; 2024-06-28T14:48:19.009240Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;storage_id=__DEFAULT;tablet_id=72075186224037888;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=0; 2024-06-28T14:48:19.009265Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;storage_id=__DEFAULT;tablet_id=72075186224037888;fline=storage.cpp:31;event=StartGC;requests_count=1; 2024-06-28T14:48:19.009286Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[4] complete at tablet 72075186224037889 2024-06-28T14:48:19.009293Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:519;event=EnqueueBackgroundActivities;periodic=0; 2024-06-28T14:48:19.009294Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:19.009298Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:697;event=start_indexation_tasks;insert_overload_size=0; 2024-06-28T14:48:19.009306Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=storage.cpp:29;event=no_granules; 2024-06-28T14:48:19.009308Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=column_engine_logs.cpp:275;event=no granules for start compaction; 2024-06-28T14:48:19.009309Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889 2024-06-28T14:48:19.009310Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889 2024-06-28T14:48:19.009312Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=column_engine_logs.cpp:316;event=StartCleanup;portions_count=0; 2024-06-28T14:48:19.009316Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=column_engine_logs.cpp:381;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0; 2024-06-28T14:48:19.009318Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:806;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.009319Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:829;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.009322Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=column_engine_logs.cpp:394;event=StartTtl;external=0; 2024-06-28T14:48:19.009325Z node 1 :TX_COLUMNSHARD WARN: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=column_engine_logs.cpp:418;event=StartTtl;skip=not_ready_tiers; 2024-06-28T14:48:19.009328Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:770;background=ttl;skip_reason=no_changes; 2024-06-28T14:48:19.009331Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;storage_id=__MEMORY;tablet_id=72075186224037889;fline=gc_info.h:20;event=extract_for_gc_skip;reason=no_data; 2024-06-28T14:48:19.009333Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;storage_id=__MEMORY;tablet_id=72075186224037889;fline=storage.cpp:37;event=start_gc_skipped;reason=cannot_extract; 2024-06-28T14:48:19.009338Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;storage_id=__DEFAULT;tablet_id=72075186224037889;fline=blob_manager.cpp:282;event=PreparePerGroupGCRequests;gen=1;step=0; 2024-06-28T14:48:19.009339Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;storage_id=__DEFAULT;tablet_id=72075186224037889;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=0; 2024-06-28T14:48:19.009347Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;storage_id=__DEFAULT;tablet_id=72075186224037889;fline=storage.cpp:31;event=StartGC;requests_count=1; 2024-06-28T14:48:19.009357Z node 1 :TX_COLUMNSHARD DEBUG: fline=gc_actor.h:40;actor=TGarbageCollectionActor;event=starting;action_id=756d2484-355d11ef-81cd8ad3-19ed9b57; 2024-06-28T14:48:19.009362Z node 1 :TX_COLUMNSHARD DEBUG: fline=gc_actor.h:40;actor=TGarbageCollectionActor;event=starting;action_id=756d2876-355d11ef-9369c455-4f931abb; 2024-06-28T14:48:19.009763Z node 1 :TX_COLUMNSHARD DEBUG: action_id=756d2484-355d11ef-81cd8ad3-19ed9b57;fline=gc_actor.cpp:7;actor=TEvCollectGarbageResult; 2024-06-28T14:48:19.009767Z node 1 :TX_COLUMNSHARD DEBUG: action_id=756d2484-355d11ef-81cd8ad3-19ed9b57;fline=gc_actor.cpp:24;actor=TGarbageCollectionActor;event=finished; 2024-06-28T14:48:19.009771Z node 1 :TX_COLUMNSHARD DEBUG: action_id=756d2876-355d11ef-9369c455-4f931abb;fline=gc_actor.cpp:7;actor=TEvCollectGarbageResult; 2024-06-28T14:48:19.009773Z node 1 :TX_COLUMNSHARD DEBUG: action_id=756d2876-355d11ef-9369c455-4f931abb;fline=gc_actor.cpp:24;actor=TGarbageCollectionActor;event=finished; 2024-06-28T14:48:19.009777Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe reset at tablet 72075186224037888 2024-06-28T14:48:19.009787Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=tx_gc_indexed.cpp:6;tx=TxGarbageCollectionFinished;event=execute; 2024-06-28T14:48:19.009791Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];tablet_id=72075186224037888;fline=gc.cpp:32;event=OnExecuteTxAfterCleaning;action_guid=756d2484-355d11ef-81cd8ad3-19ed9b57; 2024-06-28T14:48:19.009806Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe reset at tablet 72075186224037889 2024-06-28T14:48:19.009810Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=tx_gc_indexed.cpp:6;tx=TxGarbageCollectionFinished;event=execute; 2024-06-28T14:48:19.009812Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];tablet_id=72075186224037889;fline=gc.cpp:32;event=OnExecuteTxAfterCleaning;action_guid=756d2876-355d11ef-9369c455-4f931abb; 2024-06-28T14:48:19.017755Z node 1 :TX_COLUMNSHARD DEBUG: fline=tx_gc_indexed.cpp:13;tx=TxGarbageCollectionFinished;event=complete; 2024-06-28T14:48:19.017765Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=gc.cpp:10;event=OnCompleteTxAfterCleaning;action_guid=756d2484-355d11ef-81cd8ad3-19ed9b57; 2024-06-28T14:48:19.017778Z node 1 :TX_COLUMNSHARD DEBUG: fline=tx_gc_indexed.cpp:13;tx=TxGarbageCollectionFinished;event=complete; 2024-06-28T14:48:19.017781Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=gc.cpp:10;event=OnCompleteTxAfterCleaning;action_guid=756d2876-355d11ef-9369c455-4f931abb; 2024-06-28T14:48:19.021213Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037888 2024-06-28T14:48:19.021356Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=column_engine.cpp:20;total=202798010368;kff=0.3; 2024-06-28T14:48:19.021417Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=column_engine.cpp:20;total=202798010368;kff=0.3; 2024-06-28T14:48:19.021452Z node 1 :TX_COLUMNSHARD DEBUG: Write (blob) 320720 bytes into pathId 3 {object=write_monitor;count=1;size=320720} at tablet 72075186224037888 2024-06-28T14:48:19.025591Z node 1 :TX_COLUMNSHARD DEBUG: Server pipe connected at tablet 72075186224037889 2024-06-28T14:48:19.025711Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=column_engine.cpp:20;total=202798010368;kff=0.3; 2024-06-28T14:48:19.025772Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=column_engine.cpp:20;total=202798010368;kff=0.3; 2024-06-28T14:48:19.025805Z node 1 :TX_COLUMNSHARD DEBUG: Write (blob) 319568 bytes into pathId 3 {object=write_monitor;count=1;size=319568} at tablet 72075186224037889 2024-06-28T14:48:19.032637Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385566057000528041:5];fline=actor.cpp:22;event=flush_writing;size=320720;count=1; 2024-06-28T14:48:19.033235Z node 1 :TX_COLUMNSHARD DEBUG: fline=write.cpp:48;event=SendWriteBlobRequest;blob_id=DS:2181038080:[72075186224037888:1:1:2:0:646360:0]; 2024-06-28T14:48:19.037138Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385566057000528042:6];fline=actor.cpp:22;event=flush_writing;size=319568;count=1; 2024-06-28T14:48:19.037706Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=write.cpp:24;event=WriteBlobResult;blob_id=DS:2181038080:[72075186224037888:1:1:2:0:646360:0];status=OK; 2024-06-28T14:48:19.037736Z node 1 :TX_COLUMNSHARD DEBUG: Write (record) into pathId 3 at tablet 72075186224037888 2024-06-28T14:48:19.037753Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];tablet_id=72075186224037888;event=TEvWriteBlobsResult;tablet_id=72075186224037888;tx_state=execute;fline=tx_write.cpp:35;event=start_execute; 2024-06-28T14:48:19.037876Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 646360 in 1 records, committed: 0 in 0 records at tablet 72075186224037888 2024-06-28T14:48:19.037880Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037888 Save Batch GenStep: 1:1 Blob count: 1 2024-06-28T14:48:19.037883Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];tablet_id=72075186224037888;event=TEvWriteBlobsResult;tablet_id=72075186224037888;tx_state=execute;fline=blob_manager.cpp:388;to_keep=[72075186224037888:1:1:2:0:646360:0]; 2024-06-28T14:48:19.037891Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];tablet_id=72075186224037888;event=TEvWriteBlobsResult;tablet_id=72075186224037888;tx_state=execute;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=1; 2024-06-28T14:48:19.038068Z node 1 :TX_COLUMNSHARD DEBUG: fline=write.cpp:48;event=SendWriteBlobRequest;blob_id=DS:2181038080:[72075186224037889:1:1:2:0:644032:0]; 2024-06-28T14:48:19.038153Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=write.cpp:24;event=WriteBlobResult;blob_id=DS:2181038080:[72075186224037889:1:1:2:0:644032:0];status=OK; 2024-06-28T14:48:19.038167Z node 1 :TX_COLUMNSHARD DEBUG: Write (record) into pathId 3 at tablet 72075186224037889 2024-06-28T14:48:19.038175Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];tablet_id=72075186224037889;event=TEvWriteBlobsResult;tablet_id=72075186224037889;tx_state=execute;fline=tx_write.cpp:35;event=start_execute; 2024-06-28T14:48:19.038234Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 644032 in 1 records, committed: 0 in 0 records at tablet 72075186224037889 2024-06-28T14:48:19.038236Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037889 Save Batch GenStep: 1:1 Blob count: 1 2024-06-28T14:48:19.038242Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];tablet_id=72075186224037889;event=TEvWriteBlobsResult;tablet_id=72075186224037889;tx_state=execute;fline=blob_manager.cpp:388;to_keep=[72075186224037889:1:1:2:0:644032:0]; 2024-06-28T14:48:19.038250Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];tablet_id=72075186224037889;event=TEvWriteBlobsResult;tablet_id=72075186224037889;tx_state=execute;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=1; 2024-06-28T14:48:19.050155Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719586099098 at tablet 72075186224037888, mediator 72057594046382081 2024-06-28T14:48:19.050178Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[7] execute at tablet 72075186224037888 2024-06-28T14:48:19.050197Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037888; 2024-06-28T14:48:19.050246Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 646360 in 1 records at tablet 72075186224037888 2024-06-28T14:48:19.050264Z node 1 :TX_COLUMNSHARD DEBUG: PlanStep 1719586099098 at tablet 72075186224037889, mediator 72057594046382081 2024-06-28T14:48:19.050273Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[7] execute at tablet 72075186224037889 2024-06-28T14:48:19.050286Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037889; 2024-06-28T14:48:19.050326Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 644032 in 1 records at tablet 72075186224037889 2024-06-28T14:48:19.057805Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[7] complete at tablet 72075186224037889 2024-06-28T14:48:19.057835Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:519;event=EnqueueBackgroundActivities;periodic=0; 2024-06-28T14:48:19.057841Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:19.057849Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:697;event=start_indexation_tasks;insert_overload_size=644032; 2024-06-28T14:48:19.057868Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=ro_controller.cpp:35;event=CS::INDEXATION;tablet_id=72075186224037889; 2024-06-28T14:48:19.057885Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:663;event=indexation;bytes=644032;blobs_count=1;max_limit=251658240;has_more=0;external_task_id=59911c14-c067cf7b-ee5f2934-57fd443b; 2024-06-28T14:48:19.057975Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:620;event=start_changes;type=CS::INDEXATION;task_id=59911c14-c067cf7b-ee5f2934-57fd443b; 2024-06-28T14:48:19.058012Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=storage.cpp:29;event=no_granules; 2024-06-28T14:48:19.058014Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=column_engine_logs.cpp:275;event=no granules for start compaction; 2024-06-28T14:48:19.058016Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889 2024-06-28T14:48:19.058017Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889 2024-06-28T14:48:19.058021Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=column_engine_logs.cpp:316;event=StartCleanup;portions_count=0; 2024-06-28T14:48:19.058030Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=column_engine_logs.cpp:381;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0; 2024-06-28T14:48:19.058034Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:806;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.058036Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:829;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.058041Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=column_engine_logs.cpp:394;event=StartTtl;external=0; 2024-06-28T14:48:19.058047Z node 1 :TX_COLUMNSHARD WARN: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=column_engine_logs.cpp:418;event=StartTtl;skip=not_ready_tiers; 2024-06-28T14:48:19.058051Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:770;background=ttl;skip_reason=no_changes; 2024-06-28T14:48:19.058058Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;storage_id=__MEMORY;tablet_id=72075186224037889;fline=gc_info.h:20;event=extract_for_gc_skip;reason=no_data; 2024-06-28T14:48:19.058061Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;storage_id=__MEMORY;tablet_id=72075186224037889;fline=storage.cpp:37;event=start_gc_skipped;reason=cannot_extract; 2024-06-28T14:48:19.058068Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;storage_id=__DEFAULT;tablet_id=72075186224037889;fline=blob_manager.cpp:282;event=PreparePerGroupGCRequests;gen=1;step=1; 2024-06-28T14:48:19.058072Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;storage_id=__DEFAULT;tablet_id=72075186224037889;fline=blob_manager.cpp:299;to_keep_gc=[72075186224037889:1:1:2:0:644032:0]; 2024-06-28T14:48:19.058076Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;storage_id=__DEFAULT;tablet_id=72075186224037889;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=0; 2024-06-28T14:48:19.058082Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;storage_id=__DEFAULT;tablet_id=72075186224037889;fline=storage.cpp:31;event=StartGC;requests_count=1; 2024-06-28T14:48:19.058099Z node 1 :TX_COLUMNSHARD DEBUG: TxPlanStep[7] complete at tablet 72075186224037888 2024-06-28T14:48:19.058109Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:519;event=EnqueueBackgroundActivities;periodic=0; 2024-06-28T14:48:19.058111Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:19.058115Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:697;event=start_indexation_tasks;insert_overload_size=646360; 2024-06-28T14:48:19.058122Z node 1 :TX_COLUMNSHARD NOTICE: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=ro_controller.cpp:35;event=CS::INDEXATION;tablet_id=72075186224037888; 2024-06-28T14:48:19.058132Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:663;event=indexation;bytes=646360;blobs_count=1;max_limit=251658240;has_more=0;external_task_id=51957cd5-fac80885-b74d567c-b800c0bf; 2024-06-28T14:48:19.058137Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:620;event=start_changes;type=CS::INDEXATION;task_id=51957cd5-fac80885-b74d567c-b800c0bf; 2024-06-28T14:48:19.058141Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=storage.cpp:29;event=no_granules; 2024-06-28T14:48:19.058143Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=column_engine_logs.cpp:275;event=no granules for start compaction; 2024-06-28T14:48:19.058144Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888 2024-06-28T14:48:19.058145Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888 2024-06-28T14:48:19.058147Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=column_engine_logs.cpp:316;event=StartCleanup;portions_count=0; 2024-06-28T14:48:19.058151Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=column_engine_logs.cpp:381;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0; 2024-06-28T14:48:19.058153Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:806;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.058155Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:829;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.058161Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=column_engine_logs.cpp:394;event=StartTtl;external=0; 2024-06-28T14:48:19.058165Z node 1 :TX_COLUMNSHARD WARN: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=column_engine_logs.cpp:418;event=StartTtl;skip=not_ready_tiers; 2024-06-28T14:48:19.058167Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:770;background=ttl;skip_reason=no_changes; 2024-06-28T14:48:19.058171Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;storage_id=__MEMORY;tablet_id=72075186224037888;fline=gc_info.h:20;event=extract_for_gc_skip;reason=no_data; 2024-06-28T14:48:19.058176Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;storage_id=__MEMORY;tablet_id=72075186224037888;fline=storage.cpp:37;event=start_gc_skipped;reason=cannot_extract; 2024-06-28T14:48:19.058180Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;storage_id=__DEFAULT;tablet_id=72075186224037888;fline=blob_manager.cpp:282;event=PreparePerGroupGCRequests;gen=1;step=1; 2024-06-28T14:48:19.058183Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;storage_id=__DEFAULT;tablet_id=72075186224037888;fline=blob_manager.cpp:299;to_keep_gc=[72075186224037888:1:1:2:0:646360:0]; 2024-06-28T14:48:19.058185Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;storage_id=__DEFAULT;tablet_id=72075186224037888;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=0; 2024-06-28T14:48:19.058188Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;storage_id=__DEFAULT;tablet_id=72075186224037888;fline=storage.cpp:31;event=StartGC;requests_count=1; 2024-06-28T14:48:19.058201Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385566057000528042:6];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=643840;external_task_id=59911c14-c067cf7b-ee5f2934-57fd443b;type=CS::INDEXATION;priority=0;; 2024-06-28T14:48:19.058207Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385566057000528041:5];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=646162;external_task_id=51957cd5-fac80885-b74d567c-b800c0bf;type=CS::INDEXATION;priority=0;; 2024-06-28T14:48:19.058212Z node 1 :TX_COLUMNSHARD DEBUG: fline=gc_actor.h:40;actor=TGarbageCollectionActor;event=starting;action_id=75749822-355d11ef-85405b71-cf9c2639; 2024-06-28T14:48:19.058217Z node 1 :TX_COLUMNSHARD DEBUG: fline=gc_actor.h:40;actor=TGarbageCollectionActor;event=starting;action_id=75749c5a-355d11ef-a4b9ea6c-1dbc9dee; 2024-06-28T14:48:19.058474Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385566057000528042:6];fline=actor.cpp:29;event=result_resources;task_id=1;task=cpu=0;mem=643840;external_task_id=59911c14-c067cf7b-ee5f2934-57fd443b;type=CS::INDEXATION;priority=0;; 2024-06-28T14:48:19.058478Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385566057000528042:6];fline=task.cpp:9;event=resource_allocated;external_task_id=59911c14-c067cf7b-ee5f2934-57fd443b;mem=643840;cpu=0; 2024-06-28T14:48:19.058509Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385566057000528042:6];fline=task.cpp:40;event=allocate_resources;external_task_id=59911c14-c067cf7b-ee5f2934-57fd443b;task_id=1;mem=643840;cpu=0; 2024-06-28T14:48:19.058518Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385566057000528041:5];fline=actor.cpp:29;event=result_resources;task_id=2;task=cpu=0;mem=646162;external_task_id=51957cd5-fac80885-b74d567c-b800c0bf;type=CS::INDEXATION;priority=0;; 2024-06-28T14:48:19.058520Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385566057000528041:5];fline=task.cpp:9;event=resource_allocated;external_task_id=51957cd5-fac80885-b74d567c-b800c0bf;mem=646162;cpu=0; 2024-06-28T14:48:19.058537Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385566057000528041:5];fline=task.cpp:40;event=allocate_resources;external_task_id=51957cd5-fac80885-b74d567c-b800c0bf;task_id=2;mem=646162;cpu=0; 2024-06-28T14:48:19.058543Z node 1 :TX_COLUMNSHARD DEBUG: action_id=75749822-355d11ef-85405b71-cf9c2639;fline=gc_actor.cpp:7;actor=TEvCollectGarbageResult; 2024-06-28T14:48:19.058547Z node 1 :TX_COLUMNSHARD DEBUG: action_id=75749822-355d11ef-85405b71-cf9c2639;fline=gc_actor.cpp:24;actor=TGarbageCollectionActor;event=finished; 2024-06-28T14:48:19.058552Z node 1 :TX_COLUMNSHARD DEBUG: action_id=75749c5a-355d11ef-a4b9ea6c-1dbc9dee;fline=gc_actor.cpp:7;actor=TEvCollectGarbageResult; 2024-06-28T14:48:19.058554Z node 1 :TX_COLUMNSHARD DEBUG: action_id=75749c5a-355d11ef-a4b9ea6c-1dbc9dee;fline=gc_actor.cpp:24;actor=TGarbageCollectionActor;event=finished; 2024-06-28T14:48:19.060230Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=59911c14-c067cf7b-ee5f2934-57fd443b;fline=task.cpp:110;event=OnDataReady;task=agents_waiting=0;additional_info=();;external_task_id=59911c14-c067cf7b-ee5f2934-57fd443b; 2024-06-28T14:48:19.060244Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=59911c14-c067cf7b-ee5f2934-57fd443b;fline=actor.cpp:48;task=agents_waiting=0;additional_info=();; 2024-06-28T14:48:19.060252Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=51957cd5-fac80885-b74d567c-b800c0bf;fline=task.cpp:110;event=OnDataReady;task=agents_waiting=0;additional_info=();;external_task_id=51957cd5-fac80885-b74d567c-b800c0bf; 2024-06-28T14:48:19.060256Z node 1 :TX_COLUMNSHARD DEBUG: external_task_id=51957cd5-fac80885-b74d567c-b800c0bf;fline=actor.cpp:48;task=agents_waiting=0;additional_info=();; 2024-06-28T14:48:19.060273Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=tx_gc_indexed.cpp:6;tx=TxGarbageCollectionFinished;event=execute; 2024-06-28T14:48:19.060279Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];tablet_id=72075186224037889;fline=gc.cpp:32;event=OnExecuteTxAfterCleaning;action_guid=75749822-355d11ef-85405b71-cf9c2639; 2024-06-28T14:48:19.060324Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=tx_gc_indexed.cpp:6;tx=TxGarbageCollectionFinished;event=execute; 2024-06-28T14:48:19.060326Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];tablet_id=72075186224037888;fline=gc.cpp:32;event=OnExecuteTxAfterCleaning;action_guid=75749c5a-355d11ef-a4b9ea6c-1dbc9dee; 2024-06-28T14:48:19.087866Z node 1 :KQP_PROXY ERROR: Cannot start publishing usage, tenants: /Root, empty 2024-06-28T14:48:19.088433Z node 1 :KQP_PROXY ERROR: Cannot start publishing usage, tenants: /Root, empty 2024-06-28T14:48:19.088493Z node 1 :KQP_PROXY ERROR: Cannot start publishing usage, tenants: /Root, empty 2024-06-28T14:48:19.120328Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=columnshard__write_index.cpp:26;event=TEvWriteIndex;count=1; 2024-06-28T14:48:19.120469Z node 1 :TX_COLUMNSHARD DEBUG: fline=write.cpp:48;event=SendWriteBlobRequest;blob_id=DS:2181038080:[72075186224037889:1:2:2:0:167296:0]; 2024-06-28T14:48:19.138357Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=write.cpp:24;event=WriteBlobResult;blob_id=DS:2181038080:[72075186224037889:1:2:2:0:167296:0];status=OK; 2024-06-28T14:48:19.138399Z node 1 :TX_COLUMNSHARD DEBUG: fline=tx_gc_indexed.cpp:13;tx=TxGarbageCollectionFinished;event=complete; 2024-06-28T14:48:19.138404Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=gc.cpp:10;event=OnCompleteTxAfterCleaning;action_guid=75749822-355d11ef-85405b71-cf9c2639; 2024-06-28T14:48:19.138423Z node 1 :TX_COLUMNSHARD DEBUG: WriteIndex at tablet 72075186224037889 2024-06-28T14:48:19.138464Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];tablet_id=72075186224037889;external_task_id=59911c14-c067cf7b-ee5f2934-57fd443b;fline=tx_write_index.cpp:17;event=TTxWriteIndex::Execute;change_type=CS::INDEXATION;details=type=CS::INDEXATION;details=(remove=0;append=1;);; 2024-06-28T14:48:19.138491Z node 1 :TX_COLUMNSHARD DEBUG: TxWriteIndex[9] (CS::INDEXATION) apply at tablet 72075186224037889 2024-06-28T14:48:19.138626Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];tablet_id=72075186224037889;external_task_id=59911c14-c067cf7b-ee5f2934-57fd443b;fline=remove.cpp:8;event=DeclareRemove;blob_id=DS:2181038080:[72075186224037889:1:1:2:0:644032:0];tablet_id=72075186224037889; 2024-06-28T14:48:19.138644Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];tablet_id=72075186224037889;external_task_id=59911c14-c067cf7b-ee5f2934-57fd443b;fline=blob_manager.cpp:402;to_delete_on_execute=DS:2181038080:[72075186224037889:1:1:2:0:644032:0]; 2024-06-28T14:48:19.138647Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037889 Save Batch GenStep: 1:2 Blob count: 1 2024-06-28T14:48:19.138650Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];tablet_id=72075186224037889;external_task_id=59911c14-c067cf7b-ee5f2934-57fd443b;fline=blob_manager.cpp:388;to_keep=[72075186224037889:1:2:2:0:167296:0]; 2024-06-28T14:48:19.138658Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];tablet_id=72075186224037889;external_task_id=59911c14-c067cf7b-ee5f2934-57fd443b;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=1; 2024-06-28T14:48:19.138672Z 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-28T14:48:19.138679Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];tablet_id=72075186224037889;external_task_id=59911c14-c067cf7b-ee5f2934-57fd443b;fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037889; 2024-06-28T14:48:19.138719Z node 1 :TX_COLUMNSHARD DEBUG: fline=tx_gc_indexed.cpp:13;tx=TxGarbageCollectionFinished;event=complete; 2024-06-28T14:48:19.138726Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=gc.cpp:10;event=OnCompleteTxAfterCleaning;action_guid=75749c5a-355d11ef-a4b9ea6c-1dbc9dee; 2024-06-28T14:48:19.167772Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=columnshard__write_index.cpp:26;event=TEvWriteIndex;count=1; 2024-06-28T14:48:19.167850Z node 1 :TX_COLUMNSHARD DEBUG: fline=write.cpp:48;event=SendWriteBlobRequest;blob_id=DS:2181038080:[72075186224037888:1:2:2:0:167896:0]; 2024-06-28T14:48:19.167884Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=tx_write_index.cpp:55;event=TTxWriteIndex::Complete;change_type=CS::INDEXATION;details=type=CS::INDEXATION;details=(remove=0;append=1;);; 2024-06-28T14:48:19.167890Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=abstract.cpp:45;event=WriteIndexComplete;type=CS::INDEXATION;success=1; 2024-06-28T14:48:19.167946Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 0 in 0 records at tablet 72075186224037889 2024-06-28T14:48:19.167958Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=columnshard_impl.cpp:519;event=EnqueueBackgroundActivities;periodic=0; 2024-06-28T14:48:19.167963Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:19.167969Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=columnshard_impl.cpp:697;event=start_indexation_tasks;insert_overload_size=0; 2024-06-28T14:48:19.167978Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=storage.cpp:29;event=no_granules; 2024-06-28T14:48:19.167981Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=column_engine_logs.cpp:275;event=no granules for start compaction; 2024-06-28T14:48:19.167983Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889 2024-06-28T14:48:19.167985Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889 2024-06-28T14:48:19.167989Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=column_engine_logs.cpp:316;event=StartCleanup;portions_count=0; 2024-06-28T14:48:19.167994Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=column_engine_logs.cpp:381;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0; 2024-06-28T14:48:19.167999Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=columnshard_impl.cpp:806;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.168007Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=columnshard_impl.cpp:829;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.168012Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=column_engine_logs.cpp:394;event=StartTtl;external=0; 2024-06-28T14:48:19.168019Z node 1 :TX_COLUMNSHARD WARN: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=column_engine_logs.cpp:418;event=StartTtl;skip=not_ready_tiers; 2024-06-28T14:48:19.168024Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;fline=columnshard_impl.cpp:770;background=ttl;skip_reason=no_changes; 2024-06-28T14:48:19.168033Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;storage_id=__MEMORY;tablet_id=72075186224037889;fline=gc_info.h:20;event=extract_for_gc_skip;reason=no_data; 2024-06-28T14:48:19.168036Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;storage_id=__MEMORY;tablet_id=72075186224037889;fline=storage.cpp:37;event=start_gc_skipped;reason=cannot_extract; 2024-06-28T14:48:19.168044Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;storage_id=__DEFAULT;tablet_id=72075186224037889;fline=blob_manager.cpp:282;event=PreparePerGroupGCRequests;gen=1;step=2; 2024-06-28T14:48:19.168049Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;storage_id=__DEFAULT;tablet_id=72075186224037889;fline=blob_manager.cpp:299;to_keep_gc=[72075186224037889:1:2:2:0:167296:0]; 2024-06-28T14:48:19.168052Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;storage_id=__DEFAULT;tablet_id=72075186224037889;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=0; 2024-06-28T14:48:19.168058Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tablet_id=72075186224037889;storage_id=__DEFAULT;tablet_id=72075186224037889;fline=storage.cpp:31;event=StartGC;requests_count=1; 2024-06-28T14:48:19.168070Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=blob_manager.cpp:406;to_delete_on_complete=DS:2181038080:[72075186224037889:1:1:2:0:644032:0];tablet_id_delete=72075186224037889; 2024-06-28T14:48:19.168073Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037889 Delete Blob DS:2181038080:[72075186224037889:1:1:2:0:644032:0] 2024-06-28T14:48:19.168115Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:519;event=EnqueueBackgroundActivities;periodic=0; 2024-06-28T14:48:19.168116Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:19.168120Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:697;event=start_indexation_tasks;insert_overload_size=0; 2024-06-28T14:48:19.168124Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=storage.cpp:29;event=no_granules; 2024-06-28T14:48:19.168126Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=column_engine_logs.cpp:275;event=no granules for start compaction; 2024-06-28T14:48:19.168127Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037889 2024-06-28T14:48:19.168128Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037889 2024-06-28T14:48:19.168130Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=column_engine_logs.cpp:316;event=StartCleanup;portions_count=0; 2024-06-28T14:48:19.168137Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=column_engine_logs.cpp:381;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0; 2024-06-28T14:48:19.168140Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:806;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.168142Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:829;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.168144Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=column_engine_logs.cpp:394;event=StartTtl;external=0; 2024-06-28T14:48:19.168147Z node 1 :TX_COLUMNSHARD WARN: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=column_engine_logs.cpp:418;event=StartTtl;skip=not_ready_tiers; 2024-06-28T14:48:19.168150Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;fline=columnshard_impl.cpp:770;background=ttl;skip_reason=no_changes; 2024-06-28T14:48:19.168154Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;storage_id=__MEMORY;tablet_id=72075186224037889;fline=gc_info.h:20;event=extract_for_gc_skip;reason=no_data; 2024-06-28T14:48:19.168156Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;storage_id=__MEMORY;tablet_id=72075186224037889;fline=storage.cpp:37;event=start_gc_skipped;reason=cannot_extract; 2024-06-28T14:48:19.168159Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;tx_state=complete;tablet_id=72075186224037889;storage_id=__DEFAULT;tablet_id=72075186224037889;fline=storage.h:107;event=gc_in_progress; 2024-06-28T14:48:19.168224Z node 1 :TX_COLUMNSHARD DEBUG: fline=task.cpp:21;event=free_resources;task_id=1;external_task_id=59911c14-c067cf7b-ee5f2934-57fd443b;mem=643840;cpu=0; 2024-06-28T14:48:19.168253Z node 1 :TX_COLUMNSHARD DEBUG: fline=gc_actor.h:40;actor=TGarbageCollectionActor;event=starting;action_id=75856012-355d11ef-a99ea40f-411d8bb6; 2024-06-28T14:48:19.168269Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=write.cpp:24;event=WriteBlobResult;blob_id=DS:2181038080:[72075186224037888:1:2:2:0:167896:0];status=OK; 2024-06-28T14:48:19.168286Z node 1 :TX_COLUMNSHARD DEBUG: WriteIndex at tablet 72075186224037888 2024-06-28T14:48:19.168314Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];tablet_id=72075186224037888;external_task_id=51957cd5-fac80885-b74d567c-b800c0bf;fline=tx_write_index.cpp:17;event=TTxWriteIndex::Execute;change_type=CS::INDEXATION;details=type=CS::INDEXATION;details=(remove=0;append=1;);; 2024-06-28T14:48:19.168362Z node 1 :TX_COLUMNSHARD DEBUG: TxWriteIndex[9] (CS::INDEXATION) apply at tablet 72075186224037888 2024-06-28T14:48:19.168504Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];tablet_id=72075186224037888;external_task_id=51957cd5-fac80885-b74d567c-b800c0bf;fline=remove.cpp:8;event=DeclareRemove;blob_id=DS:2181038080:[72075186224037888:1:1:2:0:646360:0];tablet_id=72075186224037888; 2024-06-28T14:48:19.168515Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];tablet_id=72075186224037888;external_task_id=51957cd5-fac80885-b74d567c-b800c0bf;fline=blob_manager.cpp:402;to_delete_on_execute=DS:2181038080:[72075186224037888:1:1:2:0:646360:0]; 2024-06-28T14:48:19.168517Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037888 Save Batch GenStep: 1:2 Blob count: 1 2024-06-28T14:48:19.168520Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];tablet_id=72075186224037888;external_task_id=51957cd5-fac80885-b74d567c-b800c0bf;fline=blob_manager.cpp:388;to_keep=[72075186224037888:1:2:2:0:167896:0]; 2024-06-28T14:48:19.168526Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];tablet_id=72075186224037888;external_task_id=51957cd5-fac80885-b74d567c-b800c0bf;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=1; 2024-06-28T14:48:19.168534Z 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-28T14:48:19.168537Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];tablet_id=72075186224037888;external_task_id=51957cd5-fac80885-b74d567c-b800c0bf;fline=columnshard__progress_tx.cpp:77;event=EnqueueProgressTx;tablet_id=72075186224037888; 2024-06-28T14:48:19.168579Z node 1 :TX_COLUMNSHARD DEBUG: action_id=75856012-355d11ef-a99ea40f-411d8bb6;fline=gc_actor.cpp:7;actor=TEvCollectGarbageResult; 2024-06-28T14:48:19.168583Z node 1 :TX_COLUMNSHARD DEBUG: action_id=75856012-355d11ef-a99ea40f-411d8bb6;fline=gc_actor.cpp:24;actor=TGarbageCollectionActor;event=finished; 2024-06-28T14:48:19.168593Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=tx_gc_indexed.cpp:6;tx=TxGarbageCollectionFinished;event=execute; 2024-06-28T14:48:19.168597Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];tablet_id=72075186224037889;fline=gc.cpp:32;event=OnExecuteTxAfterCleaning;action_guid=75856012-355d11ef-a99ea40f-411d8bb6; 2024-06-28T14:48:19.173645Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=tx_write_index.cpp:55;event=TTxWriteIndex::Complete;change_type=CS::INDEXATION;details=type=CS::INDEXATION;details=(remove=0;append=1;);; 2024-06-28T14:48:19.173655Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=abstract.cpp:45;event=WriteIndexComplete;type=CS::INDEXATION;success=1; 2024-06-28T14:48:19.173693Z node 1 :TX_COLUMNSHARD INFO: InsertTable. Prepared: 0 in 0 records, committed: 0 in 0 records at tablet 72075186224037888 2024-06-28T14:48:19.173702Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=columnshard_impl.cpp:519;event=EnqueueBackgroundActivities;periodic=0; 2024-06-28T14:48:19.173707Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:19.173713Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=columnshard_impl.cpp:697;event=start_indexation_tasks;insert_overload_size=0; 2024-06-28T14:48:19.173717Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=storage.cpp:29;event=no_granules; 2024-06-28T14:48:19.173720Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=column_engine_logs.cpp:275;event=no granules for start compaction; 2024-06-28T14:48:19.173722Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888 2024-06-28T14:48:19.173724Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888 2024-06-28T14:48:19.173728Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=column_engine_logs.cpp:316;event=StartCleanup;portions_count=0; 2024-06-28T14:48:19.173733Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=column_engine_logs.cpp:381;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0; 2024-06-28T14:48:19.173737Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=columnshard_impl.cpp:806;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.173739Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=columnshard_impl.cpp:829;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.173743Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=column_engine_logs.cpp:394;event=StartTtl;external=0; 2024-06-28T14:48:19.173750Z node 1 :TX_COLUMNSHARD WARN: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=column_engine_logs.cpp:418;event=StartTtl;skip=not_ready_tiers; 2024-06-28T14:48:19.173754Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;fline=columnshard_impl.cpp:770;background=ttl;skip_reason=no_changes; 2024-06-28T14:48:19.173762Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;storage_id=__MEMORY;tablet_id=72075186224037888;fline=gc_info.h:20;event=extract_for_gc_skip;reason=no_data; 2024-06-28T14:48:19.173764Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;storage_id=__MEMORY;tablet_id=72075186224037888;fline=storage.cpp:37;event=start_gc_skipped;reason=cannot_extract; 2024-06-28T14:48:19.173772Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;storage_id=__DEFAULT;tablet_id=72075186224037888;fline=blob_manager.cpp:282;event=PreparePerGroupGCRequests;gen=1;step=2; 2024-06-28T14:48:19.173777Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;storage_id=__DEFAULT;tablet_id=72075186224037888;fline=blob_manager.cpp:299;to_keep_gc=[72075186224037888:1:2:2:0:167896:0]; 2024-06-28T14:48:19.173780Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;storage_id=__DEFAULT;tablet_id=72075186224037888;fline=blobs_manager.cpp:46;event=OnBlobsKeep;count=0; 2024-06-28T14:48:19.173787Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tablet_id=72075186224037888;storage_id=__DEFAULT;tablet_id=72075186224037888;fline=storage.cpp:31;event=StartGC;requests_count=1; 2024-06-28T14:48:19.173799Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=blob_manager.cpp:406;to_delete_on_complete=DS:2181038080:[72075186224037888:1:1:2:0:646360:0];tablet_id_delete=72075186224037888; 2024-06-28T14:48:19.173802Z node 1 :TX_COLUMNSHARD DEBUG: BlobManager at tablet 72075186224037888 Delete Blob DS:2181038080:[72075186224037888:1:1:2:0:646360:0] 2024-06-28T14:48:19.173825Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:519;event=EnqueueBackgroundActivities;periodic=0; 2024-06-28T14:48:19.173827Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:19.173830Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:697;event=start_indexation_tasks;insert_overload_size=0; 2024-06-28T14:48:19.173833Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=storage.cpp:29;event=no_granules; 2024-06-28T14:48:19.173834Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=column_engine_logs.cpp:275;event=no granules for start compaction; 2024-06-28T14:48:19.173836Z node 1 :TX_COLUMNSHARD DEBUG: Compaction not started: cannot prepare compaction at tablet 72075186224037888 2024-06-28T14:48:19.173837Z node 1 :TX_COLUMNSHARD DEBUG: ActiveCompactions: 0 at tablet 72075186224037888 2024-06-28T14:48:19.173839Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=column_engine_logs.cpp:316;event=StartCleanup;portions_count=0; 2024-06-28T14:48:19.173843Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=column_engine_logs.cpp:381;event=StartCleanup;portions_count=0;portions_prepared=0;drop=0;skip=0; 2024-06-28T14:48:19.173846Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:806;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.173848Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:829;background=cleanup;skip_reason=no_changes; 2024-06-28T14:48:19.173850Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=column_engine_logs.cpp:394;event=StartTtl;external=0; 2024-06-28T14:48:19.173853Z node 1 :TX_COLUMNSHARD WARN: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=column_engine_logs.cpp:418;event=StartTtl;skip=not_ready_tiers; 2024-06-28T14:48:19.173855Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;fline=columnshard_impl.cpp:770;background=ttl;skip_reason=no_changes; 2024-06-28T14:48:19.173858Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;storage_id=__MEMORY;tablet_id=72075186224037888;fline=gc_info.h:20;event=extract_for_gc_skip;reason=no_data; 2024-06-28T14:48:19.173860Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;storage_id=__MEMORY;tablet_id=72075186224037888;fline=storage.cpp:37;event=start_gc_skipped;reason=cannot_extract; 2024-06-28T14:48:19.173863Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;tx_state=complete;tablet_id=72075186224037888;storage_id=__DEFAULT;tablet_id=72075186224037888;fline=storage.h:107;event=gc_in_progress; 2024-06-28T14:48:19.173910Z node 1 :TX_COLUMNSHARD DEBUG: fline=task.cpp:21;event=free_resources;task_id=2;external_task_id=51957cd5-fac80885-b74d567c-b800c0bf;mem=646162;cpu=0; 2024-06-28T14:48:19.173943Z node 1 :TX_COLUMNSHARD DEBUG: fline=tx_gc_indexed.cpp:13;tx=TxGarbageCollectionFinished;event=complete; 2024-06-28T14:48:19.173946Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;fline=gc.cpp:10;event=OnCompleteTxAfterCleaning;action_guid=75856012-355d11ef-a99ea40f-411d8bb6; 2024-06-28T14:48:19.173955Z node 1 :TX_COLUMNSHARD DEBUG: fline=gc_actor.h:40;actor=TGarbageCollectionActor;event=starting;action_id=75863fdc-355d11ef-a0d33124-61173465; 2024-06-28T14:48:19.173967Z node 1 :TX_COLUMNSHARD DEBUG: action_id=75863fdc-355d11ef-a0d33124-61173465;fline=gc_actor.cpp:7;actor=TEvCollectGarbageResult; 2024-06-28T14:48:19.173970Z node 1 :TX_COLUMNSHARD DEBUG: action_id=75863fdc-355d11ef-a0d33124-61173465;fline=gc_actor.cpp:24;actor=TGarbageCollectionActor;event=finished; 2024-06-28T14:48:19.173982Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=tx_gc_indexed.cpp:6;tx=TxGarbageCollectionFinished;event=execute; 2024-06-28T14:48:19.173985Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];tablet_id=72075186224037888;fline=gc.cpp:32;event=OnExecuteTxAfterCleaning;action_guid=75863fdc-355d11ef-a0d33124-61173465; 2024-06-28T14:48:19.175069Z node 1 :TX_COLUMNSHARD DEBUG: fline=tx_gc_indexed.cpp:13;tx=TxGarbageCollectionFinished;event=complete; 2024-06-28T14:48:19.175076Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;fline=gc.cpp:10;event=OnCompleteTxAfterCleaning;action_guid=75863fdc-355d11ef-a0d33124-61173465; 2024-06-28T14:48:19.175282Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction 2024-06-28T14:48:19.175343Z node 1 :KQP_EXECUTER ERROR: kqp_predictor.cpp:134 :user pool is undefined for executer tasks construction 2024-06-28T14:48:19.179470Z node 1 :TX_COLUMNSHARD DEBUG: EvScan txId: 281474976715662 scanId: 0 version: {1719586099105:max} readable: {1719586099224:max} at tablet 72075186224037888 2024-06-28T14:48:19.179489Z node 1 :TX_COLUMNSHARD DEBUG: TTxScan prepare txId: 281474976715662 scanId: 0 at tablet 72075186224037888 2024-06-28T14:48:19.179556Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041: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-28T14:48:19.182743Z 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-28T14:48:19.183286Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385566061295495618:4342];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=641152;external_task_id=;type=CS::SCAN_READ;priority=0;; 2024-06-28T14:48:19.183300Z node 1 :TX_COLUMNSHARD DEBUG: EvScan txId: 281474976715662 scanId: 0 version: {1719586099105:max} readable: {1719586099224:max} at tablet 72075186224037889 2024-06-28T14:48:19.183308Z node 1 :TX_COLUMNSHARD DEBUG: TTxScan prepare txId: 281474976715662 scanId: 0 at tablet 72075186224037889 2024-06-28T14:48:19.183358Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];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-28T14:48:19.183427Z 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-28T14:48:19.183728Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385566061295495625:4358];fline=actor.cpp:38;event=ask_resources;task=cpu=0;mem=638848;external_task_id=;type=CS::SCAN_READ;priority=0;; 2024-06-28T14:48:19.183909Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385566061295495618:4342];fline=actor.cpp:29;event=result_resources;task_id=3;task=cpu=0;mem=641152;external_task_id=;type=CS::SCAN_READ;priority=0;; 2024-06-28T14:48:19.183915Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385566061295495618:4342];fline=task.cpp:9;event=resource_allocated;external_task_id=;mem=641152;cpu=0; 2024-06-28T14:48:19.183918Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385566061295495618:4342];fline=task.cpp:40;event=allocate_resources;external_task_id=;task_id=3;mem=641152;cpu=0; 2024-06-28T14:48:19.183929Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385566061295495625:4358];fline=actor.cpp:29;event=result_resources;task_id=4;task=cpu=0;mem=638848;external_task_id=;type=CS::SCAN_READ;priority=0;; 2024-06-28T14:48:19.183930Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385566061295495625:4358];fline=task.cpp:9;event=resource_allocated;external_task_id=;mem=638848;cpu=0; 2024-06-28T14:48:19.183933Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385566061295495625:4358];fline=task.cpp:40;event=allocate_resources;external_task_id=;task_id=4;mem=638848;cpu=0; 2024-06-28T14:48:19.184624Z node 1 :TX_COLUMNSHARD DEBUG: SelfId=[1:7385566061295495618:4342];TabletId=72075186224037888;ScanId=0;TxId=281474976715662;ScanGen=65536;method=produce result;fline=task.cpp:21;event=free_resources;task_id=3;external_task_id=;mem=641152;cpu=0; 2024-06-28T14:48:19.184644Z node 1 :TX_COLUMNSHARD DEBUG: SelfId=[1:7385566061295495625:4358];TabletId=72075186224037889;ScanId=0;TxId=281474976715662;ScanGen=65537;method=produce result;fline=task.cpp:21;event=free_resources;task_id=4;external_task_id=;mem=638848;cpu=0; VERIFY failed (2024-06-28T14:48:19.184775Z): Bad datum type: array[uint64] expected, array[int64] got ydb/library/yql/minikql/computation/mkql_block_impl.cpp:210 DoCalculate(): requirement (ArgsValuesDescr[i]) == (argDatums.back().descr()) failed 2024-06-28T14:48:19.189866Z node 1 :TX_COLUMNSHARD DEBUG: Finished read cookie: 1 at tablet 72075186224037888 2024-06-28T14:48:19.189895Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=blob_manager.cpp:433;event=blob_free;blob_id=DS:2181038080:[72075186224037888:1:2:2:0:167896:0]; 2024-06-28T14:48:19.189925Z node 1 :TX_COLUMNSHARD DEBUG: Finished read cookie: 1 at tablet 72075186224037889 2024-06-28T14:48:19.189933Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=blob_manager.cpp:433;event=blob_free;blob_id=DS:2181038080:[72075186224037889:1:2:2:0:167296:0]; 2024-06-28T14:48:19.457865Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385566057000528042:6];fline=actor.cpp:33;event=skip_flush_writing; 2024-06-28T14:48:19.459825Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385566057000528041:5];fline=actor.cpp:33;event=skip_flush_writing; 2024-06-28T14:48:19.960657Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385566057000528042:6];fline=actor.cpp:33;event=skip_flush_writing; 2024-06-28T14:48:19.960674Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385566057000528041:5];fline=actor.cpp:33;event=skip_flush_writing; 2024-06-28T14:48:19.960684Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=columnshard.cpp:169;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888; 2024-06-28T14:48:19.960690Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:19.961927Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=columnshard.cpp:169;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037889; 2024-06-28T14:48:19.961931Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:20.460831Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385566057000528042:6];fline=actor.cpp:33;event=skip_flush_writing; 2024-06-28T14:48:20.460882Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385566057000528041:5];fline=actor.cpp:33;event=skip_flush_writing; 2024-06-28T14:48:20.965590Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;self_id=[1:7385566057000528041:5];fline=columnshard.cpp:169;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037888; 2024-06-28T14:48:20.965623Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 2024-06-28T14:48:20.965643Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;parent=[1:7385566057000528042:6];fline=actor.cpp:33;event=skip_flush_writing; 2024-06-28T14:48:20.965649Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037888;parent=[1:7385566057000528041:5];fline=actor.cpp:33;event=skip_flush_writing; 2024-06-28T14:48:20.965660Z node 1 :TX_COLUMNSHARD DEBUG: tablet_id=72075186224037889;self_id=[1:7385566057000528042:6];fline=columnshard.cpp:169;event=TEvPrivate::TEvPeriodicWakeup;tablet_id=72075186224037889; 2024-06-28T14:48:20.965667Z node 1 :TX_COLUMNSHARD DEBUG: Send periodic stats. 0. /-S/util/system/yassert.cpp:83: NPrivate::InternalPanicImpl(int, char const*, char const*, int, int, int, TBasicStringBuf>, char const*, unsigned long) @ 0x11753D27 1. /-S/util/system/yassert.cpp:55: NPrivate::Panic(NPrivate::TStaticBuf const&, int, char const*, char const*, char const*, ...) @ 0x1174BA1C 2. /-S/ydb/library/yql/minikql/computation/mkql_block_impl.cpp:210: NKikimr::NMiniKQL::TBlockFuncNode::DoCalculate(NKikimr::NMiniKQL::TComputationContext&) const @ 0x164A4E71 3. /-S/ydb/library/yql/minikql/computation/mkql_computation_node_impl.h:217: NKikimr::NMiniKQL::TMutableComputationNode::GetValue(NKikimr::NMiniKQL::TComputationContext&) const @ 0x164A7A53 4. /-B/ydb/library/yql/minikql/comp_nodes/llvm14/mkql_wide_map.cpp:119: NKikimr::NMiniKQL::(anonymous namespace)::TWideMapWrapper::DoCalculate(NKikimr::NMiniKQL::TComputationContext&, NYql::NUdf::TUnboxedValue* const*) const @ 0x1E17DF88 5. /-S/ydb/library/yql/minikql/computation/mkql_computation_node_impl.h:619: NKikimr::NMiniKQL::TStatelessWideFlowComputationNode::FetchValues(NKikimr::NMiniKQL::TComputationContext&, NYql::NUdf::TUnboxedValue* const*) const @ 0x1E17DF88 6. /-B/ydb/library/yql/minikql/comp_nodes/llvm14/mkql_blocks.cpp:998: NKikimr::NMiniKQL::(anonymous namespace)::TBlockExpandChunkedWrapper::DoCalculate(NYql::NUdf::TUnboxedValue&, NKikimr::NMiniKQL::TComputationContext&, NYql::NUdf::TUnboxedValue* const*) const @ 0x1D3DFF1A 7. /-S/ydb/library/yql/minikql/computation/mkql_computation_node_impl.h:653: NKikimr::NMiniKQL::TStatefulWideFlowComputationNode::FetchValues(NKikimr::NMiniKQL::TComputationContext&, NYql::NUdf::TUnboxedValue* const*) const @ 0x1D3DFF1A 8. /-B/ydb/library/yql/minikql/comp_nodes/llvm14/mkql_blocks.cpp:538: NKikimr::NMiniKQL::(anonymous namespace)::TWideFromBlocksWrapper::DoCalculate(NYql::NUdf::TUnboxedValue&, NKikimr::NMiniKQL::TComputationContext&, NYql::NUdf::TUnboxedValue* const*) const @ 0x1D3D5B42 9. /-S/ydb/library/yql/minikql/computation/mkql_computation_node_impl.h:653: NKikimr::NMiniKQL::TStatefulWideFlowComputationNode::FetchValues(NKikimr::NMiniKQL::TComputationContext&, NYql::NUdf::TUnboxedValue* const*) const @ 0x1D3D5B42 10. /-B/ydb/library/yql/minikql/comp_nodes/llvm14/mkql_wide_map.cpp:195: NKikimr::NMiniKQL::(anonymous namespace)::TNarrowMapWrapper::DoCalculate(NKikimr::NMiniKQL::TComputationContext&) const @ 0x1E17EC2D 11. /-S/ydb/library/yql/minikql/computation/mkql_computation_node_impl.h:452: NKikimr::NMiniKQL::TStatelessFlowComputationNode::GetValue(NKikimr::NMiniKQL::TComputationContext&) const @ 0x1E17EC2D 12. /-B/ydb/library/yql/minikql/comp_nodes/llvm14/mkql_flow.cpp:185: NKikimr::NMiniKQL::(anonymous namespace)::TFromFlowWrapper::TStreamValue::Fetch(NYql::NUdf::TUnboxedValue&) @ 0x1D7AB1BF 13. /-S/ydb/library/yql/public/udf/udf_value_inl.h:217: NYql::NUdf::TBoxedValueAccessor::Fetch(NYql::NUdf::IBoxedValue&, NYql::NUdf::TUnboxedValue&) @ 0x1F4B5CC2 14. /-S/ydb/library/yql/public/udf/udf_value_inl.h:559: NYql::NUdf::TUnboxedValuePod::Fetch(NYql::NUdf::TUnboxedValue&) const @ 0x1F4B5CC2 15. /-S/ydb/library/yql/dq/runtime/dq_tasks_runner.cpp:902: NYql::NDq::TDqTaskRunner::FetchAndDispatch() @ 0x1F4B5CC2 16. /-S/ydb/library/yql/dq/runtime/dq_tasks_runner.cpp:716: NYql::NDq::TDqTaskRunner::Run() @ 0x1F4A8EB4 17. /-S/ydb/library/yql/dq/actors/compute/dq_sync_compute_actor_base.h:31: NYql::NDq::TDqSyncComputeActorBase::DoExecuteImpl() @ 0x1FD5E0AC 18. /-S/ydb/library/yql/dq/actors/compute/dq_compute_actor_impl.h:295: NYql::NDq::TDqComputeActorBase::DoExecute() @ 0x1FD5910F 19. /-S/ydb/core/kqp/compute_actor/kqp_scan_compute_actor.cpp:142: NKikimr::NKqp::NScanPrivate::TKqpScanComputeActor::Handle(TAutoPtr, TDelete>&) @ 0x1FD59A7C 20. /-S/ydb/core/kqp/compute_actor/kqp_scan_compute_actor.h:41: NKikimr::NKqp::NScanPrivate::TKqpScanComputeActor::StateFunc(TAutoPtr&) @ 0x1FD5C751 21. /-S/ydb/library/actors/core/executor_thread.cpp:250: NActors::TGenericExecutorThread::TProcessingResult NActors::TGenericExecutorThread::Execute(NActors::TMailboxTable::THTSwapMailbox*, unsigned int, bool) @ 0x1261BACA 22. /-S/ydb/library/actors/core/executor_thread.cpp:435: NActors::TGenericExecutorThread::ProcessExecutorPool(NActors::IExecutorPool*)::$_0::operator()(unsigned int, bool) const @ 0x126135A4 23. /-S/ydb/library/actors/core/executor_thread.cpp:488: NActors::TGenericExecutorThread::ProcessExecutorPool(NActors::IExecutorPool*) @ 0x12612F67 24. /-S/ydb/library/actors/core/executor_thread.cpp:517: NActors::TExecutorThread::ThreadProc() @ 0x12613E71 25. /-S/util/system/thread.cpp:244: (anonymous namespace)::TPosixThread::ThreadProxy(void*) @ 0x117590BB 26. ??:0: ?? @ 0x7F0ADF2B1AC2 27. ??:0: ?? @ 0x7F0ADF34384F