2025-10-14T14:22:09.007841Z node 1 :METADATA_PROVIDER WARN: log.cpp:841: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[1:7561082603474360886:2080];send_to=[0:7307199536658146131:7762515];
2025-10-14T14:22:09.012726Z node 1 :METADATA_PROVIDER ERROR: log.cpp:841: fline=accessor_snapshot_base.cpp:71;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=scheme_cache_undelivered_message;
test_client.cpp: SetPath # /home/runner/.ya/build/build_root/8izf/0012f9/r3tmp/tmpC2vRmC/pdisk_1.dat
2025-10-14T14:22:09.256689Z node 1 :KQP_PROXY WARN: kqp_finalize_script_service.cpp:135: [ScriptExecutions] [TKqpFinalizeScriptService] Failed to check script execution tables existence, scheme status: LookupError, path: Root/.metadata/script_executions
2025-10-14T14:22:09.279740Z node 1 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-10-14T14:22:09.279870Z node 1 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-10-14T14:22:09.286949Z node 1 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(1, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-10-14T14:22:09.297843Z node 1 :IMPORT WARN: schemeshard_import.cpp:307: Table profiles were not loaded
TServer::EnableGrpc on GrpcPort 1725, node 1
2025-10-14T14:22:09.470325Z node 1 :KQP_PROXY WARN: kqp_finalize_script_service.cpp:135: [ScriptExecutions] [TKqpFinalizeScriptService] Failed to check script execution tables existence, scheme status: PathErrorUnknown, path: Root/.metadata/script_executions
2025-10-14T14:22:09.475332Z node 1 :NET_CLASSIFIER WARN: net_classifier.cpp:190: distributable config is empty, broken or outdated, will use file: (empty maybe)
2025-10-14T14:22:09.475356Z node 1 :NET_CLASSIFIER WARN: net_classifier.cpp:196: will try to initialize from file: (empty maybe)
2025-10-14T14:22:09.475362Z node 1 :NET_CLASSIFIER WARN: net_classifier.cpp:204: failed to initialize from file: (empty maybe)
2025-10-14T14:22:09.475482Z node 1 :NET_CLASSIFIER ERROR: net_classifier.cpp:228: got bad distributable configuration
TClient is connected to server localhost:12524
WaitRootIsUp 'Root'...
TClient::Ls request: Root
TClient::Ls response: Status: 1
StatusCode: SUCCESS
SchemeStatus: 0
PathDescription {
  Self {
    Name: "Root"
    PathId: 1
    SchemeshardId: 72057594046644480
    PathType: EPathTypeDir
    CreateFinished: true
    CreateTxId: 1
    CreateStep: 0
    ParentPathId: 1
    PathState: EPathStateNoChanges
    Owner: "root@builtin"
    ACL: ""
    EffectiveACL: ""
    PathVersion: 2
    PathSubType: EPathSubTypeEmpty
    Version {
      GeneralVersion: 2
      ACLVersion: 0
      EffectiveACLVersion: 0
      UserAttrsVersion: 1
      ChildrenVersion: 1
      SubDomainVersion: 0
      SecurityStateVersion: 0
    }
    ChildrenExist: false
  }
  Children {
    Name: ".sys"
    PathId: 18446744073709551615
    SchemeshardId: 72057594046644480
    PathType: EPathTypeDir
    CreateFinished: true
    CreateTxId: 0
    CreateStep: 0
    ParentPathId: 18446744073709551615
  }
  DomainDescription {
    SchemeShardId_Depricated: 72057594046644480
    PathId_Depricated: 1
    ProcessingParams {
      Version: 0
      Pl...
(TRUNCATED)
WaitRootIsUp 'Root' success.
2025-10-14T14:22:09.736941Z node 1 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 281474976710657:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_alter_subdomain.cpp:311)
waiting...
2025-10-14T14:22:09.835220Z node 1 :GRPC_SERVER INFO: grpc_request_proxy.cpp:592: Got grpc request# ListEndpointsRequest, traceId# 01k7hhk6d907ts6qfz5exxr9z0, sdkBuildInfo# ydb-cpp-sdk/dev, state# AS_NOT_PERFORMED, database# undef, peer# ipv6:[::1]:54652, grpcInfo# grpc-c++/1.54.3 grpc-c/31.0.0 (linux; chttp2), timeout# 9.993254s
2025-10-14T14:22:09.886411Z node 1 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:595: Got grpc request# CreateSessionRequest, traceId# 01k7hhk6e56nv0a262gmed9qfx, sdkBuildInfo# ydb-cpp-sdk/dev, state# AS_NOT_PERFORMED, database# undef, peer# ipv6:[::1]:54656, grpcInfo# grpc-c++/1.54.3 grpc-c/31.0.0 (linux; chttp2), timeout# undef
2025-10-14T14:22:10.024562Z node 1 :TX_CONVEYOR ERROR: log.cpp:841: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-10-14T14:22:12.131126Z node 1 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:595: Got grpc request# CreateTableRequest, traceId# 01k7hhk8n20nebd605px941prb, sdkBuildInfo# ydb-cpp-sdk/dev, state# AS_NOT_PERFORMED, database# undef, peer# ipv6:[::1]:54660, grpcInfo# grpc-c++/1.54.3 grpc-c/31.0.0 (linux; chttp2), timeout# undef
2025-10-14T14:22:12.132967Z node 1 :TX_PROXY DEBUG: proxy_impl.cpp:314: actor# [1:7561082603474361090:2145] Handle TEvProposeTransaction
2025-10-14T14:22:12.133002Z node 1 :TX_PROXY DEBUG: proxy_impl.cpp:237: actor# [1:7561082603474361090:2145] TxId# 281474976710658 ProcessProposeTransaction
2025-10-14T14:22:12.133042Z node 1 :TX_PROXY DEBUG: proxy_impl.cpp:256: actor# [1:7561082603474361090:2145] Cookie# 0 userReqId# "" txid# 281474976710658 SEND to# [1:7561082616359263767:2628]
2025-10-14T14:22:12.212560Z node 1 :TX_PROXY DEBUG: schemereq.cpp:1673: Actor# [1:7561082616359263767:2628] txid# 281474976710658 Bootstrap EvSchemeRequest record: Transaction { ModifyScheme { WorkingDir: "/Root" OperationType: ESchemeOpCreateTable CreateTable { Name: "Test" Columns { Name: "Key" Type: "Uint32" NotNull: false } Columns { Name: "Fk" Type: "Uint64" NotNull: false } Columns { Name: "Value" Type: "String" NotNull: false } KeyColumnNames: "Key" KeyColumnNames: "Fk" UniformPartitionsCount: 16 PartitionConfig { } Temporary: false } CreateIndexedTable { } } } DatabaseName: "" RequestType: "" PeerName: "ipv6:[::1]:54660" 
2025-10-14T14:22:12.212611Z node 1 :TX_PROXY DEBUG: schemereq.cpp:613: Actor# [1:7561082616359263767:2628] txid# 281474976710658 Bootstrap, UserSID: <empty> CheckAdministrator: 0 CheckDatabaseAdministrator: 0
2025-10-14T14:22:12.213361Z node 1 :TX_PROXY DEBUG: schemereq.cpp:1738: Actor# [1:7561082616359263767:2628] txid# 281474976710658 HANDLE EvNavigateKeySetResult TFlatSchemeReq marker# P6
2025-10-14T14:22:12.213458Z node 1 :TX_PROXY DEBUG: schemereq.cpp:1728: Actor# [1:7561082616359263767:2628] txid# 281474976710658 TEvNavigateKeySet requested from SchemeCache
2025-10-14T14:22:12.213658Z node 1 :TX_PROXY DEBUG: schemereq.cpp:1561: Actor# [1:7561082616359263767:2628] txid# 281474976710658 HANDLE EvNavigateKeySetResult TFlatSchemeReq marker# P5 ErrorCount# 0
2025-10-14T14:22:12.213798Z node 1 :TX_PROXY DEBUG: schemereq.cpp:1608: Actor# [1:7561082616359263767:2628] HANDLE EvNavigateKeySetResult, txid# 281474976710658 shardToRequest# 72057594046644480 DomainKey# [OwnerId: 72057594046644480, LocalPathId: 1] DomainInfo.Params# Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 RedirectRequired# true
2025-10-14T14:22:12.213836Z node 1 :TX_PROXY DEBUG: schemereq.cpp:103: Actor# [1:7561082616359263767:2628] txid# 281474976710658 SEND to# 72057594046644480 shardToRequest {TEvModifySchemeTransaction txid# 281474976710658 TabletId# 72057594046644480}
2025-10-14T14:22:12.213942Z node 1 :TX_PROXY DEBUG: schemereq.cpp:1463: Actor# [1:7561082616359263767:2628] txid# 281474976710658 HANDLE EvClientConnected
2025-10-14T14:22:12.215786Z node 1 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710658:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:684)
2025-10-14T14:22:12.221878Z node 1 :TX_PROXY DEBUG: schemereq.cpp:1485: Actor# [1:7561082616359263767:2628] txid# 281474976710658 Status StatusAccepted HANDLE {TEvModifySchemeTransactionResult Status# StatusAccepted txid# 281474976710658}
2025-10-14T14:22:12.221969Z node 1 :TX_PROXY DEBUG: schemereq.cpp:593: Actor# [1:7561082616359263767:2628] txid# 281474976710658 SEND to# [1:7561082616359263766:2319] Source {TEvProposeTransactionStatus txid# 281474976710658 Status# 53}
2025-10-14T14:22:12.222879Z node 1 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:489: SchemeBoardUpdate /Root
2025-10-14T14:22:12.222977Z node 1 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:518: Can't update SecurityState for /Root - no PublicKeys
2025-10-14T14:22:12.222994Z node 1 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:489: SchemeBoardUpdate /Root
2025-10-14T14:22:12.223039Z node 1 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:518: Can't update SecurityState for /Root - no PublicKeys
2025-10-14T14:22:12.298382Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263821:2680], Recipient [1:7561082616359263987:2327]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.304499Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263830:2689], Recipient [1:7561082616359263982:2323]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.312439Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263833:2692], Recipient [1:7561082616359264024:2335]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.313960Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263826:2685], Recipient [1:7561082616359263981:2322]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.314429Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263832:2691], Recipient [1:7561082616359263984:2325]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.314607Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263820:2679], Recipient [1:7561082616359263985:2326]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.316816Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263824:2683], Recipient [1:7561082616359264009:2331]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.317367Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263822:2681], Recipient [1:7561082616359264012:2332]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.318032Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263828:2687], Recipient [1:7561082616359264008:2330]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.318400Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263827:2686], Recipient [1:7561082616359264025:2336]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.318717Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263829:2688], Recipient [1:7561082616359263983:2324]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.321649Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263825:2684], Recipient [1:7561082616359263999:2328]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.322081Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263832:2691], Recipient [1:7561082616359263984:2325]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.322833Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263825:2684], Recipient [1:7561082616359263999:2328]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.323272Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037902 actor [1:7561082616359263999:2328]
2025-10-14T14:22:12.323562Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.327764Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037894 actor [1:7561082616359263984:2325]
2025-10-14T14:22:12.327970Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.340041Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263826:2685], Recipient [1:7561082616359263981:2322]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.340597Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037901 actor [1:7561082616359263981:2322]
2025-10-14T14:22:12.340824Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.342832Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263829:2688], Recipient [1:7561082616359263983:2324]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.343236Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037898 actor [1:7561082616359263983:2324]
2025-10-14T14:22:12.343435Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.348532Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263826:2685], Recipient [1:7561082616359263981:2322]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.348652Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263822:2681], Recipient [1:7561082616359264012:2332]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.349086Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037891 actor [1:7561082616359264012:2332]
2025-10-14T14:22:12.349278Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.352690Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263829:2688], Recipient [1:7561082616359263983:2324]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.352798Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263827:2686], Recipient [1:7561082616359264025:2336]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.353194Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037900 actor [1:7561082616359264025:2336]
2025-10-14T14:22:12.353396Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.358416Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263822:2681], Recipient [1:7561082616359264012:2332]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.358805Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263824:2683], Recipient [1:7561082616359264009:2331]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.359245Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037903 actor [1:7561082616359264009:2331]
2025-10-14T14:22:12.359494Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.363792Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263832:2691], Recipient [1:7561082616359263984:2325]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.363918Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.363965Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.365896Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037894
2025-10-14T14:22:12.365947Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037894
2025-10-14T14:22:12.365973Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037894
2025-10-14T14:22:12.366367Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.366403Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.366428Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037894 persisting started state actor id [1:7561082616359264285:2325] in generation 1
2025-10-14T14:22:12.366619Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263834:2693], Recipient [1:7561082616359264034:2337]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.367448Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263834:2693], Recipient [1:7561082616359264034:2337]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.367795Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037892 actor [1:7561082616359264034:2337]
2025-10-14T14:22:12.367984Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.371962Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263828:2687], Recipient [1:7561082616359264008:2330]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.372416Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037899 actor [1:7561082616359264008:2330]
2025-10-14T14:22:12.372663Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.377429Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263831:2690], Recipient [1:7561082616359264006:2329]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.378126Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263831:2690], Recipient [1:7561082616359264006:2329]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.378423Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037896 actor [1:7561082616359264006:2329]
2025-10-14T14:22:12.378573Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.382215Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263827:2686], Recipient [1:7561082616359264025:2336]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.382362Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.382417Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.385350Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037900
2025-10-14T14:22:12.385385Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037900
2025-10-14T14:22:12.385410Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037900
2025-10-14T14:22:12.385714Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.385753Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.385771Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037900 persisting started state actor id [1:7561082616359264313:2336] in generation 1
2025-10-14T14:22:12.385896Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263821:2680], Recipient [1:7561082616359263987:2327]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.386340Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037889 actor [1:7561082616359263987:2327]
2025-10-14T14:22:12.386536Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.387132Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263831:2690], Recipient [1:7561082616359264006:2329]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.387237Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263823:2682], Recipient [1:7561082616359264019:2334]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.388045Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263823:2682], Recipient [1:7561082616359264019:2334]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.388398Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037895 actor [1:7561082616359264019:2334]
2025-10-14T14:22:12.388689Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.394935Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263821:2680], Recipient [1:7561082616359263987:2327]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.395057Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263825:2684], Recipient [1:7561082616359263999:2328]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.395160Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.395205Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.395645Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263823:2682], Recipient [1:7561082616359264019:2334]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.395741Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828672, Sender [1:7561082616359263835:2694], Recipient [1:7561082616359264013:2333]: NKikimr::TEvTablet::TEvBoot
2025-10-14T14:22:12.396695Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263835:2694], Recipient [1:7561082616359264013:2333]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.396989Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037890 actor [1:7561082616359264013:2333]
2025-10-14T14:22:12.397116Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037902
2025-10-14T14:22:12.397162Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037902
2025-10-14T14:22:12.397191Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037902
2025-10-14T14:22:12.397206Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.398365Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.398423Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.398443Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037902 persisting started state actor id [1:7561082616359264339:2328] in generation 1
2025-10-14T14:22:12.398676Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263824:2683], Recipient [1:7561082616359264009:2331]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.398756Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.398788Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.400221Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037903
2025-10-14T14:22:12.400244Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037903
2025-10-14T14:22:12.400292Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037903
2025-10-14T14:22:12.400541Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.400589Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.400619Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037903 persisting started state actor id [1:7561082616359264341:2331] in generation 1
2025-10-14T14:22:12.400745Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263828:2687], Recipient [1:7561082616359264008:2330]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.400851Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.400898Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.402080Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037899
2025-10-14T14:22:12.402125Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037899
2025-10-14T14:22:12.402152Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037899
2025-10-14T14:22:12.402340Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.402362Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.402372Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037899 persisting started state actor id [1:7561082616359264343:2330] in generation 1
2025-10-14T14:22:12.402483Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.402516Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.403798Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037901
2025-10-14T14:22:12.403834Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037901
2025-10-14T14:22:12.403867Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037901
2025-10-14T14:22:12.404093Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.404118Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.404136Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037901 persisting started state actor id [1:7561082616359264345:2322] in generation 1
2025-10-14T14:22:12.404246Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.404281Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.405574Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037898
2025-10-14T14:22:12.405597Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037898
2025-10-14T14:22:12.405671Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037898
2025-10-14T14:22:12.405859Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.405888Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.405899Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037898 persisting started state actor id [1:7561082616359264347:2324] in generation 1
2025-10-14T14:22:12.406004Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.406028Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.406474Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263830:2689], Recipient [1:7561082616359263982:2323]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.406927Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037897 actor [1:7561082616359263982:2323]
2025-10-14T14:22:12.407223Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.407467Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037891
2025-10-14T14:22:12.407504Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037891
2025-10-14T14:22:12.407552Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037891
2025-10-14T14:22:12.407863Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.407890Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.407909Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037891 persisting started state actor id [1:7561082616359264356:2332] in generation 1
2025-10-14T14:22:12.408128Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263833:2692], Recipient [1:7561082616359264024:2335]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.408556Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037893 actor [1:7561082616359264024:2335]
2025-10-14T14:22:12.408819Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.416121Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263830:2689], Recipient [1:7561082616359263982:2323]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.416234Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.416289Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.416631Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263833:2692], Recipient [1:7561082616359264024:2335]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.416739Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3109: StateInit, received event# 268828673, Sender [1:7561082616359263820:2679], Recipient [1:7561082616359263985:2326]: NKikimr::TEvTablet::TEvRestored
2025-10-14T14:22:12.417330Z node 1 :TX_DATASHARD INFO: datashard.cpp:373: TDataShard::OnActivateExecutor: tablet 72075186224037888 actor [1:7561082616359263985:2326]
2025-10-14T14:22:12.417526Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-10-14T14:22:12.418089Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037896
2025-10-14T14:22:12.418151Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037896
2025-10-14T14:22:12.418193Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037896
2025-10-14T14:22:12.418525Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.418583Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.418624Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037896 persisting started state actor id [1:7561082616359264373:2329] in generation 1
2025-10-14T14:22:12.418795Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.418851Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.420393Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037889
2025-10-14T14:22:12.420416Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037889
2025-10-14T14:22:12.420497Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037889
2025-10-14T14:22:12.420754Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.420779Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.420791Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037889 persisting started state actor id [1:7561082616359264376:2327] in generation 1
2025-10-14T14:22:12.420910Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.420933Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.422409Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037895
2025-10-14T14:22:12.422426Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037895
2025-10-14T14:22:12.422444Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037895
2025-10-14T14:22:12.422664Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.422700Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.422713Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037895 persisting started state actor id [1:7561082616359264378:2334] in generation 1
2025-10-14T14:22:12.423128Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263834:2693], Recipient [1:7561082616359264034:2337]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.423219Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.423250Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.424659Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037892
2025-10-14T14:22:12.424688Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037892
2025-10-14T14:22:12.424708Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037892
2025-10-14T14:22:12.424979Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.424998Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.425009Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037892 persisting started state actor id [1:7561082616359264389:2337] in generation 1
2025-10-14T14:22:12.425170Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263835:2694], Recipient [1:7561082616359264013:2333]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.425245Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.425305Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.426370Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037890
2025-10-14T14:22:12.426398Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037890
2025-10-14T14:22:12.426420Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037890
2025-10-14T14:22:12.426565Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.426581Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.426606Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037890 persisting started state actor id [1:7561082616359264393:2333] in generation 1
2025-10-14T14:22:12.426672Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.432368Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.470904Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037894
2025-10-14T14:22:12.470914Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037898
2025-10-14T14:22:12.471051Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037898 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.471059Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037894 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.471097Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037894, actorId: [1:7561082616359264412:2338]
2025-10-14T14:22:12.471107Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037894
2025-10-14T14:22:12.471122Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037894, state: WaitScheme
2025-10-14T14:22:12.471133Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037894
2025-10-14T14:22:12.471211Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.471227Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037900
2025-10-14T14:22:12.471290Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037900 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.471310Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037900, actorId: [1:7561082616359264413:2339]
2025-10-14T14:22:12.471314Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037900
2025-10-14T14:22:12.471319Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037900, state: WaitScheme
2025-10-14T14:22:12.471324Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037900
2025-10-14T14:22:12.471414Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359264025:2336], Recipient [1:7561082616359264025:2336]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.471435Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.471619Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037898, actorId: [1:7561082616359264414:2340]
2025-10-14T14:22:12.471630Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037898
2025-10-14T14:22:12.471650Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037898, state: WaitScheme
2025-10-14T14:22:12.471659Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037898
2025-10-14T14:22:12.471737Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.471777Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037899
2025-10-14T14:22:12.471838Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037899 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.471859Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037899, actorId: [1:7561082616359264415:2341]
2025-10-14T14:22:12.471864Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037899
2025-10-14T14:22:12.471870Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037899, state: WaitScheme
2025-10-14T14:22:12.471875Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037899
2025-10-14T14:22:12.471958Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359264008:2330], Recipient [1:7561082616359264008:2330]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.471982Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.473751Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037900
2025-10-14T14:22:12.473755Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037899
2025-10-14T14:22:12.473809Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037900
2025-10-14T14:22:12.473839Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037899
2025-10-14T14:22:12.473891Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359263992:2795], Recipient [1:7561082616359264025:2336]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.473920Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359264005:2800], Recipient [1:7561082616359264008:2330]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.473938Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.473942Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.473973Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037899, clientId# [1:7561082616359263942:2767], serverId# [1:7561082616359264005:2800], sessionId# [0:0:0]
2025-10-14T14:22:12.473981Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037900, clientId# [1:7561082616359263943:2768], serverId# [1:7561082616359263992:2795], sessionId# [0:0:0]
2025-10-14T14:22:12.474020Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359264005:2800]
2025-10-14T14:22:12.474031Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359263992:2795]
2025-10-14T14:22:12.474039Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.474044Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.474140Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037900
2025-10-14T14:22:12.474151Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037899
2025-10-14T14:22:12.474165Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037899 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.474166Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037900 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.474187Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037900
2025-10-14T14:22:12.474194Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037899
2025-10-14T14:22:12.474202Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037900 has no attached operations
2025-10-14T14:22:12.474203Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037899 has no attached operations
2025-10-14T14:22:12.474211Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037900
2025-10-14T14:22:12.474212Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037899
2025-10-14T14:22:12.474218Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037900 TxInFly 0
2025-10-14T14:22:12.474219Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037899 TxInFly 0
2025-10-14T14:22:12.474240Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037900
2025-10-14T14:22:12.474241Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037899
2025-10-14T14:22:12.474261Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037900
2025-10-14T14:22:12.474262Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037899
2025-10-14T14:22:12.474487Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037900 on unit CheckSchemeTx
2025-10-14T14:22:12.474509Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037899 on unit CheckSchemeTx
2025-10-14T14:22:12.474516Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037900 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.474528Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037899 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.474581Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037900
2025-10-14T14:22:12.474604Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037899
2025-10-14T14:22:12.474615Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037900 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.474647Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037900 executing on unit CheckSchemeTx
2025-10-14T14:22:12.474660Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037900 to execution unit StoreSchemeTx
2025-10-14T14:22:12.474664Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037899 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.474673Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037900 on unit StoreSchemeTx
2025-10-14T14:22:12.474703Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037899 executing on unit CheckSchemeTx
2025-10-14T14:22:12.474715Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037899 to execution unit StoreSchemeTx
2025-10-14T14:22:12.474724Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037899 on unit StoreSchemeTx
2025-10-14T14:22:12.475022Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037899 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.475039Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037899 executing on unit StoreSchemeTx
2025-10-14T14:22:12.475048Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037899 to execution unit FinishPropose
2025-10-14T14:22:12.475058Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037899 on unit FinishPropose
2025-10-14T14:22:12.475095Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037899 is DelayComplete
2025-10-14T14:22:12.475115Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037899 executing on unit FinishPropose
2025-10-14T14:22:12.475129Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037900 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.475139Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037900 executing on unit StoreSchemeTx
2025-10-14T14:22:12.475142Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037899 to execution unit WaitForPlan
2025-10-14T14:22:12.475145Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037900 to execution unit FinishPropose
2025-10-14T14:22:12.475150Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037899 on unit WaitForPlan
2025-10-14T14:22:12.475151Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037900 on unit FinishPropose
2025-10-14T14:22:12.475165Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037899 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.475167Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037900 is DelayComplete
2025-10-14T14:22:12.475174Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037900 executing on unit FinishPropose
2025-10-14T14:22:12.475180Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037900 to execution unit WaitForPlan
2025-10-14T14:22:12.475203Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037900 on unit WaitForPlan
2025-10-14T14:22:12.475209Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037900 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.475285Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.475309Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037901
2025-10-14T14:22:12.475370Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037901 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.475416Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3122: StateInactive, received event# 268828684, Sender [1:7561082616359263820:2679], Recipient [1:7561082616359263985:2326]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-14T14:22:12.475433Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037901, actorId: [1:7561082616359264426:2342]
2025-10-14T14:22:12.475442Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037901
2025-10-14T14:22:12.475449Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037901, state: WaitScheme
2025-10-14T14:22:12.475457Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037901
2025-10-14T14:22:12.475486Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.475517Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.475538Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359263981:2322], Recipient [1:7561082616359263981:2322]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.475553Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.475598Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037901
2025-10-14T14:22:12.475662Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037901
2025-10-14T14:22:12.475777Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359264002:2798], Recipient [1:7561082616359263981:2322]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.475797Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.475818Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037901, clientId# [1:7561082616359263944:2769], serverId# [1:7561082616359264002:2798], sessionId# [0:0:0]
2025-10-14T14:22:12.475844Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037901
2025-10-14T14:22:12.475856Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037901 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.475864Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037901
2025-10-14T14:22:12.475872Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037901 has no attached operations
2025-10-14T14:22:12.475878Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037901
2025-10-14T14:22:12.475884Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037901 TxInFly 0
2025-10-14T14:22:12.475898Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037901
2025-10-14T14:22:12.475948Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359264002:2798]
2025-10-14T14:22:12.475973Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.476038Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037901
2025-10-14T14:22:12.476185Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037901 on unit CheckSchemeTx
2025-10-14T14:22:12.476213Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037901 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.476257Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037901
2025-10-14T14:22:12.476292Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037901 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.476305Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037901 executing on unit CheckSchemeTx
2025-10-14T14:22:12.476318Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037901 to execution unit StoreSchemeTx
2025-10-14T14:22:12.476327Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037901 on unit StoreSchemeTx
2025-10-14T14:22:12.476642Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037901 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.476691Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037901 executing on unit StoreSchemeTx
2025-10-14T14:22:12.476717Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037901 to execution unit FinishPropose
2025-10-14T14:22:12.476735Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037901 on unit FinishPropose
2025-10-14T14:22:12.476761Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037901 is DelayComplete
2025-10-14T14:22:12.476788Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037901 executing on unit FinishPropose
2025-10-14T14:22:12.476826Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037901 to execution unit WaitForPlan
2025-10-14T14:22:12.476836Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037901 on unit WaitForPlan
2025-10-14T14:22:12.476846Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037901 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.476888Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037888
2025-10-14T14:22:12.476914Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037888
2025-10-14T14:22:12.476973Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037888
2025-10-14T14:22:12.476999Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359263981:2322]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.477022Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037901
2025-10-14T14:22:12.477090Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.477140Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037903
2025-10-14T14:22:12.477176Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037903 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.477197Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037903, actorId: [1:7561082616359264432:2343]
2025-10-14T14:22:12.477204Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037903
2025-10-14T14:22:12.477211Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037903, state: WaitScheme
2025-10-14T14:22:12.477218Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037903
2025-10-14T14:22:12.477257Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.477267Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359264009:2331], Recipient [1:7561082616359264009:2331]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.477278Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.477289Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.477307Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037888 persisting started state actor id [1:7561082616359264433:2326] in generation 1
2025-10-14T14:22:12.477331Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037903
2025-10-14T14:22:12.477373Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037903
2025-10-14T14:22:12.477387Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037903
2025-10-14T14:22:12.477395Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037903 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.477418Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037903
2025-10-14T14:22:12.477428Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037903 has no attached operations
2025-10-14T14:22:12.477434Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037903
2025-10-14T14:22:12.477439Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037903 TxInFly 0
2025-10-14T14:22:12.477453Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037903
2025-10-14T14:22:12.477460Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.477492Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.477493Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359264007:2801], Recipient [1:7561082616359264009:2331]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.477503Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.477515Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037903, clientId# [1:7561082616359263946:2771], serverId# [1:7561082616359264007:2801], sessionId# [0:0:0]
2025-10-14T14:22:12.477737Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.477773Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037891
2025-10-14T14:22:12.477800Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037891 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.477818Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037891, actorId: [1:7561082616359264435:2344]
2025-10-14T14:22:12.477824Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037891
2025-10-14T14:22:12.477830Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037891, state: WaitScheme
2025-10-14T14:22:12.477836Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037891
2025-10-14T14:22:12.477900Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359264012:2332], Recipient [1:7561082616359264012:2332]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.477912Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.477981Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037891
2025-10-14T14:22:12.478045Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037891
2025-10-14T14:22:12.478063Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037891
2025-10-14T14:22:12.478091Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037891 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.478099Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037891
2025-10-14T14:22:12.478105Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037891 has no attached operations
2025-10-14T14:22:12.478110Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037891
2025-10-14T14:22:12.478115Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037891 TxInFly 0
2025-10-14T14:22:12.478126Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037891
2025-10-14T14:22:12.478188Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359264008:2330]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.478206Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037899
2025-10-14T14:22:12.478843Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037893
2025-10-14T14:22:12.478874Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037893
2025-10-14T14:22:12.478897Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037893
2025-10-14T14:22:12.478970Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359264025:2336]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.478995Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037900
2025-10-14T14:22:12.479212Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359263984:2325], Recipient [1:7561082616359263984:2325]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.479226Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.479322Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037894
2025-10-14T14:22:12.479374Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037894
2025-10-14T14:22:12.479456Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359264004:2799], Recipient [1:7561082616359263984:2325]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.479470Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.479487Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037894, clientId# [1:7561082616359263937:2762], serverId# [1:7561082616359264004:2799], sessionId# [0:0:0]
2025-10-14T14:22:12.479530Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359264004:2799]
2025-10-14T14:22:12.479545Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.479618Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037894
2025-10-14T14:22:12.479630Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037894 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.479638Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037894
2025-10-14T14:22:12.479653Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037894 has no attached operations
2025-10-14T14:22:12.479662Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037894
2025-10-14T14:22:12.479669Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037894 TxInFly 0
2025-10-14T14:22:12.479687Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037894
2025-10-14T14:22:12.479706Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037894
2025-10-14T14:22:12.479855Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037894 on unit CheckSchemeTx
2025-10-14T14:22:12.479882Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037894 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.479961Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037894
2025-10-14T14:22:12.479985Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037894 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.479995Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037894 executing on unit CheckSchemeTx
2025-10-14T14:22:12.480003Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037894 to execution unit StoreSchemeTx
2025-10-14T14:22:12.480011Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037894 on unit StoreSchemeTx
2025-10-14T14:22:12.480235Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037894 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.480247Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037894 executing on unit StoreSchemeTx
2025-10-14T14:22:12.480254Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037894 to execution unit FinishPropose
2025-10-14T14:22:12.480261Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037894 on unit FinishPropose
2025-10-14T14:22:12.480282Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037894 is DelayComplete
2025-10-14T14:22:12.480292Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037894 executing on unit FinishPropose
2025-10-14T14:22:12.480299Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037894 to execution unit WaitForPlan
2025-10-14T14:22:12.480305Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037894 on unit WaitForPlan
2025-10-14T14:22:12.480318Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037894 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.480522Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-10-14T14:22:12.480560Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-10-14T14:22:12.481714Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.481739Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.481753Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037893 persisting started state actor id [1:7561082616359264449:2335] in generation 1
2025-10-14T14:22:12.481848Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359263983:2324], Recipient [1:7561082616359263983:2324]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.481859Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.481905Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037898
2025-10-14T14:22:12.481942Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037898
2025-10-14T14:22:12.481989Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359264010:2802], Recipient [1:7561082616359263983:2324]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.482000Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.482014Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037898, clientId# [1:7561082616359263941:2766], serverId# [1:7561082616359264010:2802], sessionId# [0:0:0]
2025-10-14T14:22:12.482047Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359264010:2802]
2025-10-14T14:22:12.482061Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.482111Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037898
2025-10-14T14:22:12.482121Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037898 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.482128Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037898
2025-10-14T14:22:12.482136Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037898 has no attached operations
2025-10-14T14:22:12.482142Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037898
2025-10-14T14:22:12.482148Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037898 TxInFly 0
2025-10-14T14:22:12.482161Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037898
2025-10-14T14:22:12.482176Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037898
2025-10-14T14:22:12.482263Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037898 on unit CheckSchemeTx
2025-10-14T14:22:12.482276Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037898 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.482320Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037898
2025-10-14T14:22:12.482333Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037898 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.482364Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037898 executing on unit CheckSchemeTx
2025-10-14T14:22:12.482375Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037898 to execution unit StoreSchemeTx
2025-10-14T14:22:12.482391Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037898 on unit StoreSchemeTx
2025-10-14T14:22:12.482624Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037898 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.482635Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037898 executing on unit StoreSchemeTx
2025-10-14T14:22:12.482641Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037898 to execution unit FinishPropose
2025-10-14T14:22:12.482648Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037898 on unit FinishPropose
2025-10-14T14:22:12.482664Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037898 is DelayComplete
2025-10-14T14:22:12.482673Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037898 executing on unit FinishPropose
2025-10-14T14:22:12.482680Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037898 to execution unit WaitForPlan
2025-10-14T14:22:12.482687Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037898 on unit WaitForPlan
2025-10-14T14:22:12.482695Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037898 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.482789Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359263983:2324]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.482806Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037898
2025-10-14T14:22:12.482963Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.483000Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037902
2025-10-14T14:22:12.483057Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037902 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.483081Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037902, actorId: [1:7561082616359264452:2345]
2025-10-14T14:22:12.483098Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037902
2025-10-14T14:22:12.483109Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037902, state: WaitScheme
2025-10-14T14:22:12.483117Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037902
2025-10-14T14:22:12.483192Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359263999:2328], Recipient [1:7561082616359263999:2328]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.483203Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.483244Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037902
2025-10-14T14:22:12.483293Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037902
2025-10-14T14:22:12.483313Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037902
2025-10-14T14:22:12.483325Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037902 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.483331Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037902
2025-10-14T14:22:12.483338Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037902 has no attached operations
2025-10-14T14:22:12.483344Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037902
2025-10-14T14:22:12.483349Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037902 TxInFly 0
2025-10-14T14:22:12.483359Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037902
2025-10-14T14:22:12.483448Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.483458Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037890
2025-10-14T14:22:12.483482Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037890 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.483498Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037890, actorId: [1:7561082616359264453:2346]
2025-10-14T14:22:12.483517Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037890
2025-10-14T14:22:12.483526Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037890, state: WaitScheme
2025-10-14T14:22:12.483531Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037890
2025-10-14T14:22:12.483585Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359264013:2333], Recipient [1:7561082616359264013:2333]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.483594Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.483627Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037890
2025-10-14T14:22:12.483661Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037890
2025-10-14T14:22:12.483671Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037890
2025-10-14T14:22:12.483678Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037890 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.483684Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037890
2025-10-14T14:22:12.483689Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037890 has no attached operations
2025-10-14T14:22:12.483695Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037890
2025-10-14T14:22:12.483699Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037890 TxInFly 0
2025-10-14T14:22:12.483709Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037890
2025-10-14T14:22:12.483731Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.483740Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037892
2025-10-14T14:22:12.483782Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037892 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.483816Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037892, actorId: [1:7561082616359264454:2347]
2025-10-14T14:22:12.483825Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037892
2025-10-14T14:22:12.483845Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037892, state: WaitScheme
2025-10-14T14:22:12.483854Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037892
2025-10-14T14:22:12.483906Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359264034:2337], Recipient [1:7561082616359264034:2337]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.483915Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.483949Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037892
2025-10-14T14:22:12.483978Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037892
2025-10-14T14:22:12.483988Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037892
2025-10-14T14:22:12.483995Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037892 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.484000Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037892
2025-10-14T14:22:12.484014Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037892 has no attached operations
2025-10-14T14:22:12.484022Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037892
2025-10-14T14:22:12.484026Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037892 TxInFly 0
2025-10-14T14:22:12.484038Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037892
2025-10-14T14:22:12.484198Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359264007:2801]
2025-10-14T14:22:12.484207Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.484252Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037903
2025-10-14T14:22:12.484369Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037903 on unit CheckSchemeTx
2025-10-14T14:22:12.484384Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037903 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.484440Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037903
2025-10-14T14:22:12.484454Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037903 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.484464Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037903 executing on unit CheckSchemeTx
2025-10-14T14:22:12.484471Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037903 to execution unit StoreSchemeTx
2025-10-14T14:22:12.484485Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037903 on unit StoreSchemeTx
2025-10-14T14:22:12.484672Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037903 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.484682Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037903 executing on unit StoreSchemeTx
2025-10-14T14:22:12.484690Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037903 to execution unit FinishPropose
2025-10-14T14:22:12.484697Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037903 on unit FinishPropose
2025-10-14T14:22:12.484711Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037903 is DelayComplete
2025-10-14T14:22:12.484720Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037903 executing on unit FinishPropose
2025-10-14T14:22:12.484726Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037903 to execution unit WaitForPlan
2025-10-14T14:22:12.484739Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037903 on unit WaitForPlan
2025-10-14T14:22:12.484750Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037903 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.484836Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.484845Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037896
2025-10-14T14:22:12.484889Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037896 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.484907Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037896, actorId: [1:7561082616359264455:2348]
2025-10-14T14:22:12.484911Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037896
2025-10-14T14:22:12.484917Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037896, state: WaitScheme
2025-10-14T14:22:12.484922Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037896
2025-10-14T14:22:12.484977Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359264006:2329], Recipient [1:7561082616359264006:2329]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.484996Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.485032Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037896
2025-10-14T14:22:12.485078Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037896
2025-10-14T14:22:12.485088Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037896
2025-10-14T14:22:12.485095Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037896 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.485100Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037896
2025-10-14T14:22:12.485109Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037896 has no attached operations
2025-10-14T14:22:12.485115Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037896
2025-10-14T14:22:12.485133Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037896 TxInFly 0
2025-10-14T14:22:12.485154Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037896
2025-10-14T14:22:12.485199Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359264001:2797], Recipient [1:7561082616359264012:2332]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.485209Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.485223Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037891, clientId# [1:7561082616359263929:2754], serverId# [1:7561082616359264001:2797], sessionId# [0:0:0]
2025-10-14T14:22:12.485245Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359264001:2797]
2025-10-14T14:22:12.485253Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.485288Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037891
2025-10-14T14:22:12.485486Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037891 on unit CheckSchemeTx
2025-10-14T14:22:12.485499Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037891 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.485533Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037891
2025-10-14T14:22:12.485543Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037891 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.485551Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037891 executing on unit CheckSchemeTx
2025-10-14T14:22:12.485557Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037891 to execution unit StoreSchemeTx
2025-10-14T14:22:12.485568Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037891 on unit StoreSchemeTx
2025-10-14T14:22:12.485713Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037891 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.485722Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037891 executing on unit StoreSchemeTx
2025-10-14T14:22:12.485737Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037891 to execution unit FinishPropose
2025-10-14T14:22:12.485745Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037891 on unit FinishPropose
2025-10-14T14:22:12.485757Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037891 is DelayComplete
2025-10-14T14:22:12.485765Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037891 executing on unit FinishPropose
2025-10-14T14:22:12.485771Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037891 to execution unit WaitForPlan
2025-10-14T14:22:12.485776Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037891 on unit WaitForPlan
2025-10-14T14:22:12.485781Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037891 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.485865Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359263984:2325]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.485880Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037894
2025-10-14T14:22:12.488352Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1323: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037897
2025-10-14T14:22:12.488375Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1379: LoadLockChangeRecords at tablet: 72075186224037897
2025-10-14T14:22:12.488413Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1428: LoadChangeRecordCommits at tablet: 72075186224037897
2025-10-14T14:22:12.488518Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359263990:2793], Recipient [1:7561082616359264034:2337]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.488532Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.488548Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037892, clientId# [1:7561082616359263932:2757], serverId# [1:7561082616359263990:2793], sessionId# [0:0:0]
2025-10-14T14:22:12.488670Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359263990:2793]
2025-10-14T14:22:12.488680Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.488722Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-10-14T14:22:12.488753Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037892
2025-10-14T14:22:12.488754Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-10-14T14:22:12.488773Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037897 persisting started state actor id [1:7561082616359264463:2323] in generation 1
2025-10-14T14:22:12.488880Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037892 on unit CheckSchemeTx
2025-10-14T14:22:12.488894Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037892 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.488927Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037892
2025-10-14T14:22:12.488954Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037892 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.488999Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359264009:2331]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.489002Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037892 executing on unit CheckSchemeTx
2025-10-14T14:22:12.489019Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037892 to execution unit StoreSchemeTx
2025-10-14T14:22:12.489028Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037903
2025-10-14T14:22:12.489069Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037892 on unit StoreSchemeTx
2025-10-14T14:22:12.489226Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359264012:2332]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.489244Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037891
2025-10-14T14:22:12.489285Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037892 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.489302Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037892 executing on unit StoreSchemeTx
2025-10-14T14:22:12.489309Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037892 to execution unit FinishPropose
2025-10-14T14:22:12.489309Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359263980:2789], Recipient [1:7561082616359264006:2329]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.489316Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037892 on unit FinishPropose
2025-10-14T14:22:12.489329Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037892 is DelayComplete
2025-10-14T14:22:12.489337Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.489346Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037892 executing on unit FinishPropose
2025-10-14T14:22:12.489354Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037892 to execution unit WaitForPlan
2025-10-14T14:22:12.489354Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037896, clientId# [1:7561082616359263939:2764], serverId# [1:7561082616359263980:2789], sessionId# [0:0:0]
2025-10-14T14:22:12.489361Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037892 on unit WaitForPlan
2025-10-14T14:22:12.489387Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037892 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.489394Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359263980:2789]
2025-10-14T14:22:12.489430Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.489475Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037896
2025-10-14T14:22:12.489521Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359264034:2337]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.489549Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037892
2025-10-14T14:22:12.489576Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037896 on unit CheckSchemeTx
2025-10-14T14:22:12.489595Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037896 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.489617Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037899
2025-10-14T14:22:12.489640Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037899 on unit StoreSchemeTx
2025-10-14T14:22:12.489642Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037896
2025-10-14T14:22:12.489650Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037899 on unit FinishPropose
2025-10-14T14:22:12.489655Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037896 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.489662Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037896 executing on unit CheckSchemeTx
2025-10-14T14:22:12.489669Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037896 to execution unit StoreSchemeTx
2025-10-14T14:22:12.489676Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037896 on unit StoreSchemeTx
2025-10-14T14:22:12.489685Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037899 send to client, exec latency: 0 ms, propose latency: 15 ms, status: PREPARED
2025-10-14T14:22:12.489724Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037899 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.489761Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037900
2025-10-14T14:22:12.489778Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037900 on unit StoreSchemeTx
2025-10-14T14:22:12.489791Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037900 on unit FinishPropose
2025-10-14T14:22:12.489804Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037900 send to client, exec latency: 1 ms, propose latency: 15 ms, status: PREPARED
2025-10-14T14:22:12.489816Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037900 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.489846Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037901
2025-10-14T14:22:12.489854Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037901 on unit StoreSchemeTx
2025-10-14T14:22:12.489860Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037901 on unit FinishPropose
2025-10-14T14:22:12.489871Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037896 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.489888Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037901 send to client, exec latency: 0 ms, propose latency: 13 ms, status: PREPARED
2025-10-14T14:22:12.489906Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037896 executing on unit StoreSchemeTx
2025-10-14T14:22:12.489915Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037901 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.489919Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037896 to execution unit FinishPropose
2025-10-14T14:22:12.489942Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037896 on unit FinishPropose
2025-10-14T14:22:12.489961Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037896 is DelayComplete
2025-10-14T14:22:12.489961Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.489969Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037896 executing on unit FinishPropose
2025-10-14T14:22:12.489975Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037896 to execution unit WaitForPlan
2025-10-14T14:22:12.489979Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037889
2025-10-14T14:22:12.489982Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037896 on unit WaitForPlan
2025-10-14T14:22:12.489988Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037896 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.490011Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037889 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.490038Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037889, actorId: [1:7561082616359264470:2349]
2025-10-14T14:22:12.490046Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037889
2025-10-14T14:22:12.490053Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037889, state: WaitScheme
2025-10-14T14:22:12.490059Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037889
2025-10-14T14:22:12.490069Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.490104Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037888
2025-10-14T14:22:12.490154Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037888 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.490176Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037888, actorId: [1:7561082616359264471:2350]
2025-10-14T14:22:12.490178Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359263987:2327], Recipient [1:7561082616359263987:2327]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.490182Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037888
2025-10-14T14:22:12.490187Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037888, state: WaitScheme
2025-10-14T14:22:12.490190Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.490193Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037888
2025-10-14T14:22:12.490230Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037889
2025-10-14T14:22:12.490238Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359263985:2326], Recipient [1:7561082616359263985:2326]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.490246Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.490274Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037889
2025-10-14T14:22:12.490290Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037889
2025-10-14T14:22:12.490299Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037889 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.490316Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037889
2025-10-14T14:22:12.490327Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037889 has no attached operations
2025-10-14T14:22:12.490335Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037889
2025-10-14T14:22:12.490354Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037889 TxInFly 0
2025-10-14T14:22:12.490364Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037888
2025-10-14T14:22:12.490373Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037889
2025-10-14T14:22:12.490395Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037888
2025-10-14T14:22:12.490396Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.490405Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037895
2025-10-14T14:22:12.490407Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037888
2025-10-14T14:22:12.490433Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037888 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.490437Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037895 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.490440Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037888
2025-10-14T14:22:12.490445Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037888 has no attached operations
2025-10-14T14:22:12.490449Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037888
2025-10-14T14:22:12.490454Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037888 TxInFly 0
2025-10-14T14:22:12.490454Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037895, actorId: [1:7561082616359264472:2351]
2025-10-14T14:22:12.490459Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037895
2025-10-14T14:22:12.490464Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037895, state: WaitScheme
2025-10-14T14:22:12.490468Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037895
2025-10-14T14:22:12.490480Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037888
2025-10-14T14:22:12.490509Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.490517Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037893
2025-10-14T14:22:12.490524Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359264019:2334], Recipient [1:7561082616359264019:2334]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.490538Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037893 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.490551Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037893, actorId: [1:7561082616359264473:2352]
2025-10-14T14:22:12.490562Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037893
2025-10-14T14:22:12.490568Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037893, state: WaitScheme
2025-10-14T14:22:12.490568Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.490573Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037893
2025-10-14T14:22:12.490605Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037895
2025-10-14T14:22:12.490628Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359264024:2335], Recipient [1:7561082616359264024:2335]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.490639Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.490657Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037895
2025-10-14T14:22:12.490672Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037893
2025-10-14T14:22:12.490688Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037895
2025-10-14T14:22:12.490697Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037895 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.490702Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037895
2025-10-14T14:22:12.490707Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037895 has no attached operations
2025-10-14T14:22:12.490719Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037895
2025-10-14T14:22:12.490725Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037895 TxInFly 0
2025-10-14T14:22:12.490739Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037893
2025-10-14T14:22:12.490765Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037893
2025-10-14T14:22:12.490779Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037895
2025-10-14T14:22:12.490811Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037898
2025-10-14T14:22:12.490820Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037898 on unit StoreSchemeTx
2025-10-14T14:22:12.490828Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037893 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.490836Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037898 on unit FinishPropose
2025-10-14T14:22:12.490837Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037893
2025-10-14T14:22:12.490842Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037893 has no attached operations
2025-10-14T14:22:12.490846Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037893
2025-10-14T14:22:12.490848Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037898 send to client, exec latency: 0 ms, propose latency: 8 ms, status: PREPARED
2025-10-14T14:22:12.490851Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037893 TxInFly 0
2025-10-14T14:22:12.490882Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037893
2025-10-14T14:22:12.490889Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037898 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.490978Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037894
2025-10-14T14:22:12.490989Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037894 on unit StoreSchemeTx
2025-10-14T14:22:12.490996Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037894 on unit FinishPropose
2025-10-14T14:22:12.491006Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037894 send to client, exec latency: 0 ms, propose latency: 11 ms, status: PREPARED
2025-10-14T14:22:12.491016Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037894 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.491034Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359264006:2329]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.491049Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037896
2025-10-14T14:22:12.491074Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359263988:2791], Recipient [1:7561082616359263987:2327]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.491085Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.491098Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037889, clientId# [1:7561082616359263924:2749], serverId# [1:7561082616359263988:2791], sessionId# [0:0:0]
2025-10-14T14:22:12.491143Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359263989:2792], Recipient [1:7561082616359263999:2328]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.491152Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.491181Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037902, clientId# [1:7561082616359263945:2770], serverId# [1:7561082616359263989:2792], sessionId# [0:0:0]
2025-10-14T14:22:12.491206Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359263986:2790], Recipient [1:7561082616359263985:2326]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.491215Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.491233Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037888, clientId# [1:7561082616359263920:2745], serverId# [1:7561082616359263986:2790], sessionId# [0:0:0]
2025-10-14T14:22:12.491234Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359263989:2792]
2025-10-14T14:22:12.491245Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.491271Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359264000:2796], Recipient [1:7561082616359264013:2333]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.491278Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.491311Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037890, clientId# [1:7561082616359263927:2752], serverId# [1:7561082616359264000:2796], sessionId# [0:0:0]
2025-10-14T14:22:12.491337Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359264000:2796]
2025-10-14T14:22:12.491348Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.491355Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037902
2025-10-14T14:22:12.491403Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037890
2025-10-14T14:22:12.491478Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037902 on unit CheckSchemeTx
2025-10-14T14:22:12.491495Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037902 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.491495Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037890 on unit CheckSchemeTx
2025-10-14T14:22:12.491516Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037890 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.491534Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037902
2025-10-14T14:22:12.491543Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037890
2025-10-14T14:22:12.491545Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037902 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.491553Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037890 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.491554Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037902 executing on unit CheckSchemeTx
2025-10-14T14:22:12.491560Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037890 executing on unit CheckSchemeTx
2025-10-14T14:22:12.491561Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037902 to execution unit StoreSchemeTx
2025-10-14T14:22:12.491566Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037890 to execution unit StoreSchemeTx
2025-10-14T14:22:12.491568Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037902 on unit StoreSchemeTx
2025-10-14T14:22:12.491573Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037890 on unit StoreSchemeTx
2025-10-14T14:22:12.491752Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037902 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.491752Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037890 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.491762Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037902 executing on unit StoreSchemeTx
2025-10-14T14:22:12.491762Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037890 executing on unit StoreSchemeTx
2025-10-14T14:22:12.491768Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037902 to execution unit FinishPropose
2025-10-14T14:22:12.491769Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037890 to execution unit FinishPropose
2025-10-14T14:22:12.491775Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037902 on unit FinishPropose
2025-10-14T14:22:12.491775Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037890 on unit FinishPropose
2025-10-14T14:22:12.491788Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037902 is DelayComplete
2025-10-14T14:22:12.491804Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037902 executing on unit FinishPropose
2025-10-14T14:22:12.491804Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037890 is DelayComplete
2025-10-14T14:22:12.491814Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037890 executing on unit FinishPropose
2025-10-14T14:22:12.491820Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037890 to execution unit WaitForPlan
2025-10-14T14:22:12.491827Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037902 to execution unit WaitForPlan
2025-10-14T14:22:12.491836Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037890 on unit WaitForPlan
2025-10-14T14:22:12.491843Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037890 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.491854Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037902 on unit WaitForPlan
2025-10-14T14:22:12.491865Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037902 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.491955Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359263991:2794], Recipient [1:7561082616359264024:2335]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.491963Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359263974:2783], Recipient [1:7561082616359264019:2334]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.491966Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.491973Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.491979Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037893, clientId# [1:7561082616359263935:2760], serverId# [1:7561082616359263991:2794], sessionId# [0:0:0]
2025-10-14T14:22:12.491990Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037895, clientId# [1:7561082616359263938:2763], serverId# [1:7561082616359263974:2783], sessionId# [0:0:0]
2025-10-14T14:22:12.492306Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359263974:2783]
2025-10-14T14:22:12.492316Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.492385Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037895
2025-10-14T14:22:12.492508Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037895 on unit CheckSchemeTx
2025-10-14T14:22:12.492527Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037895 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.492562Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037895
2025-10-14T14:22:12.492573Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037895 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.492612Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037895 executing on unit CheckSchemeTx
2025-10-14T14:22:12.492642Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037895 to execution unit StoreSchemeTx
2025-10-14T14:22:12.492662Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037895 on unit StoreSchemeTx
2025-10-14T14:22:12.492909Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037895 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.492927Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037895 executing on unit StoreSchemeTx
2025-10-14T14:22:12.492937Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037895 to execution unit FinishPropose
2025-10-14T14:22:12.492951Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037895 on unit FinishPropose
2025-10-14T14:22:12.492975Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037895 is DelayComplete
2025-10-14T14:22:12.492986Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037895 executing on unit FinishPropose
2025-10-14T14:22:12.492993Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037895 to execution unit WaitForPlan
2025-10-14T14:22:12.493001Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037895 on unit WaitForPlan
2025-10-14T14:22:12.493008Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037895 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.493163Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359264019:2334]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.493183Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037895
2025-10-14T14:22:12.493227Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359263988:2791]
2025-10-14T14:22:12.493240Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.493301Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037889
2025-10-14T14:22:12.493399Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037889 on unit CheckSchemeTx
2025-10-14T14:22:12.493412Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037889 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.493448Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037889
2025-10-14T14:22:12.493459Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037889 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.493495Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037889 executing on unit CheckSchemeTx
2025-10-14T14:22:12.493505Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037889 to execution unit StoreSchemeTx
2025-10-14T14:22:12.493514Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037889 on unit StoreSchemeTx
2025-10-14T14:22:12.493744Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037889 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.493758Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037889 executing on unit StoreSchemeTx
2025-10-14T14:22:12.493765Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037889 to execution unit FinishPropose
2025-10-14T14:22:12.493772Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037889 on unit FinishPropose
2025-10-14T14:22:12.493786Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037889 is DelayComplete
2025-10-14T14:22:12.493794Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037889 executing on unit FinishPropose
2025-10-14T14:22:12.493800Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037889 to execution unit WaitForPlan
2025-10-14T14:22:12.493810Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037889 on unit WaitForPlan
2025-10-14T14:22:12.493817Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037889 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.493921Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359263987:2327]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.493956Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037889
2025-10-14T14:22:12.494021Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037891
2025-10-14T14:22:12.494032Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037891 on unit StoreSchemeTx
2025-10-14T14:22:12.494038Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037891 on unit FinishPropose
2025-10-14T14:22:12.494048Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037891 send to client, exec latency: 0 ms, propose latency: 8 ms, status: PREPARED
2025-10-14T14:22:12.494065Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037891 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.494096Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037903
2025-10-14T14:22:12.494104Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037903 on unit StoreSchemeTx
2025-10-14T14:22:12.494111Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037903 on unit FinishPropose
2025-10-14T14:22:12.494118Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037903 send to client, exec latency: 0 ms, propose latency: 9 ms, status: PREPARED
2025-10-14T14:22:12.494131Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037903 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.494166Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359263991:2794]
2025-10-14T14:22:12.494174Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.494207Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037893
2025-10-14T14:22:12.494286Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037893 on unit CheckSchemeTx
2025-10-14T14:22:12.494315Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037893 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.494354Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037893
2025-10-14T14:22:12.494366Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037893 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.494374Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037893 executing on unit CheckSchemeTx
2025-10-14T14:22:12.494380Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037893 to execution unit StoreSchemeTx
2025-10-14T14:22:12.494392Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037893 on unit StoreSchemeTx
2025-10-14T14:22:12.494571Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037893 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.494581Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037893 executing on unit StoreSchemeTx
2025-10-14T14:22:12.494587Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037893 to execution unit FinishPropose
2025-10-14T14:22:12.494594Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037893 on unit FinishPropose
2025-10-14T14:22:12.494608Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037893 is DelayComplete
2025-10-14T14:22:12.494617Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037893 executing on unit FinishPropose
2025-10-14T14:22:12.494624Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037893 to execution unit WaitForPlan
2025-10-14T14:22:12.494631Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037893 on unit WaitForPlan
2025-10-14T14:22:12.494637Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037893 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.494758Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359263999:2328]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.494785Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037902
2025-10-14T14:22:12.494928Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359264013:2333]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.494943Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037890
2025-10-14T14:22:12.495126Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359263986:2790]
2025-10-14T14:22:12.495135Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.495215Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037888
2025-10-14T14:22:12.495303Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037888 on unit CheckSchemeTx
2025-10-14T14:22:12.495314Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037888 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.495358Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037888
2025-10-14T14:22:12.495377Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037888 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.495402Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037888 executing on unit CheckSchemeTx
2025-10-14T14:22:12.495428Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037888 to execution unit StoreSchemeTx
2025-10-14T14:22:12.495441Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037888 on unit StoreSchemeTx
2025-10-14T14:22:12.495647Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037888 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.495657Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037888 executing on unit StoreSchemeTx
2025-10-14T14:22:12.495664Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037888 to execution unit FinishPropose
2025-10-14T14:22:12.495670Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037888 on unit FinishPropose
2025-10-14T14:22:12.495683Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037888 is DelayComplete
2025-10-14T14:22:12.495690Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037888 executing on unit FinishPropose
2025-10-14T14:22:12.495696Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037888 to execution unit WaitForPlan
2025-10-14T14:22:12.495702Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037888 on unit WaitForPlan
2025-10-14T14:22:12.495708Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037888 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.495836Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359263985:2326]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.495855Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037888
2025-10-14T14:22:12.495905Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037892
2025-10-14T14:22:12.495916Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037892 on unit StoreSchemeTx
2025-10-14T14:22:12.495922Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037892 on unit FinishPropose
2025-10-14T14:22:12.495933Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037892 send to client, exec latency: 0 ms, propose latency: 7 ms, status: PREPARED
2025-10-14T14:22:12.495983Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037892 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.496230Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359264024:2335]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.496247Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037893
2025-10-14T14:22:12.496333Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037896
2025-10-14T14:22:12.496343Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037896 on unit StoreSchemeTx
2025-10-14T14:22:12.496349Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037896 on unit FinishPropose
2025-10-14T14:22:12.496362Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037896 send to client, exec latency: 0 ms, propose latency: 6 ms, status: PREPARED
2025-10-14T14:22:12.496381Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037896 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.496412Z node 1 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-10-14T14:22:12.496461Z node 1 :TX_DATASHARD INFO: datashard.cpp:417: Switched to work state WaitScheme tabletId 72075186224037897
2025-10-14T14:22:12.496506Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:457: 72075186224037897 not sending time cast registration request in state WaitScheme: missing processing params
2025-10-14T14:22:12.496533Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1258: Change sender created: at tablet: 72075186224037897, actorId: [1:7561082616359264498:2353]
2025-10-14T14:22:12.496549Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:1263: Trying to activate change sender: at tablet: 72075186224037897
2025-10-14T14:22:12.496556Z node 1 :TX_DATASHARD INFO: datashard.cpp:1280: Cannot activate change sender: at tablet: 72075186224037897, state: WaitScheme
2025-10-14T14:22:12.496563Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037897
2025-10-14T14:22:12.496611Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359263982:2323], Recipient [1:7561082616359263982:2323]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.496622Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.496675Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037897
2025-10-14T14:22:12.496723Z node 1 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037897
2025-10-14T14:22:12.496738Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037897
2025-10-14T14:22:12.496756Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037897 active 0 active planned 0 immediate 0 planned 0
2025-10-14T14:22:12.496766Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037897
2025-10-14T14:22:12.496774Z node 1 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037897 has no attached operations
2025-10-14T14:22:12.496780Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037897
2025-10-14T14:22:12.496786Z node 1 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037897 TxInFly 0
2025-10-14T14:22:12.496799Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037897
2025-10-14T14:22:12.498056Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359264011:2803], Recipient [1:7561082616359263982:2323]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.498069Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.498107Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037897, clientId# [1:7561082616359263940:2765], serverId# [1:7561082616359264011:2803], sessionId# [0:0:0]
2025-10-14T14:22:12.499204Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269549568, Sender [1:7561082603474361192:2200], Recipient [1:7561082616359264011:2803]
2025-10-14T14:22:12.499216Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3149: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-10-14T14:22:12.499265Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037897
2025-10-14T14:22:12.499355Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037897 on unit CheckSchemeTx
2025-10-14T14:22:12.499390Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037897 txId 281474976710658 ssId 72057594046644480 seqNo 2:1
2025-10-14T14:22:12.499440Z node 1 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976710658 at tablet 72075186224037897
2025-10-14T14:22:12.499469Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037897 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.499481Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037897 executing on unit CheckSchemeTx
2025-10-14T14:22:12.499489Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037897 to execution unit StoreSchemeTx
2025-10-14T14:22:12.499512Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037897 on unit StoreSchemeTx
2025-10-14T14:22:12.499731Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037897 is DelayCompleteNoMoreRestarts
2025-10-14T14:22:12.499749Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037897 executing on unit StoreSchemeTx
2025-10-14T14:22:12.499756Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037897 to execution unit FinishPropose
2025-10-14T14:22:12.499766Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037897 on unit FinishPropose
2025-10-14T14:22:12.499782Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976710658] at 72075186224037897 is DelayComplete
2025-10-14T14:22:12.499791Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976710658] at 72075186224037897 executing on unit FinishPropose
2025-10-14T14:22:12.499797Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976710658] at 72075186224037897 to execution unit WaitForPlan
2025-10-14T14:22:12.499803Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976710658] at 72075186224037897 on unit WaitForPlan
2025-10-14T14:22:12.499808Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976710658] at 72075186224037897 is not ready to execute on unit WaitForPlan
2025-10-14T14:22:12.499892Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359263982:2323]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.499910Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037897
2025-10-14T14:22:12.501220Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037888
2025-10-14T14:22:12.501233Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037888 on unit StoreSchemeTx
2025-10-14T14:22:12.501241Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037888 on unit FinishPropose
2025-10-14T14:22:12.501254Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037888 send to client, exec latency: 0 ms, propose latency: 6 ms, status: PREPARED
2025-10-14T14:22:12.501279Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037888 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.501309Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037890
2025-10-14T14:22:12.501311Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037902
2025-10-14T14:22:12.501318Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037890 on unit StoreSchemeTx
2025-10-14T14:22:12.501330Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037890 on unit FinishPropose
2025-10-14T14:22:12.501340Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037902 on unit StoreSchemeTx
2025-10-14T14:22:12.501356Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037902 on unit FinishPropose
2025-10-14T14:22:12.501366Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037890 send to client, exec latency: 0 ms, propose latency: 9 ms, status: PREPARED
2025-10-14T14:22:12.501381Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037890 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.501397Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037902 send to client, exec latency: 0 ms, propose latency: 10 ms, status: PREPARED
2025-10-14T14:22:12.501411Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037902 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.501422Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037889
2025-10-14T14:22:12.501431Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037889 on unit StoreSchemeTx
2025-10-14T14:22:12.501437Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037889 on unit FinishPropose
2025-10-14T14:22:12.501441Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037895
2025-10-14T14:22:12.501445Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037889 send to client, exec latency: 0 ms, propose latency: 8 ms, status: PREPARED
2025-10-14T14:22:12.501449Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037895 on unit StoreSchemeTx
2025-10-14T14:22:12.501455Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037895 on unit FinishPropose
2025-10-14T14:22:12.501456Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037889 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.501463Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037895 send to client, exec latency: 0 ms, propose latency: 9 ms, status: PREPARED
2025-10-14T14:22:12.501476Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037895 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.501482Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037893
2025-10-14T14:22:12.501490Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037893 on unit StoreSchemeTx
2025-10-14T14:22:12.501505Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037893 on unit FinishPropose
2025-10-14T14:22:12.501516Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037893 send to client, exec latency: 0 ms, propose latency: 7 ms, status: PREPARED
2025-10-14T14:22:12.501527Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037893 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.504945Z node 1 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037897
2025-10-14T14:22:12.504959Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037897 on unit StoreSchemeTx
2025-10-14T14:22:12.504967Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976710658] at 72075186224037897 on unit FinishPropose
2025-10-14T14:22:12.504982Z node 1 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976710658 at tablet 72075186224037897 send to client, exec latency: 0 ms, propose latency: 5 ms, status: PREPARED
2025-10-14T14:22:12.505011Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:467: 72075186224037897 not sending time cast registration request in state WaitScheme
2025-10-14T14:22:12.509486Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359264557:3201], Recipient [1:7561082616359264009:2331]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.509511Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.509544Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037903, clientId# [1:7561082616359264553:3197], serverId# [1:7561082616359264557:3201], sessionId# [0:0:0]
2025-10-14T14:22:12.509587Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269287424, Sender [1:7561082603474361451:2383], Recipient [1:7561082616359264009:2331]: {TEvPlanStep step# 1760451732557 MediatorId# 72057594046382081 TabletID 72075186224037903}
2025-10-14T14:22:12.509600Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3161: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-10-14T14:22:12.509697Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1806: Trying to execute [1760451732557:281474976710658] at 72075186224037903 on unit WaitForPlan
2025-10-14T14:22:12.509713Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1821: Execution status for [1760451732557:281474976710658] at 72075186224037903 is Executed
2025-10-14T14:22:12.509732Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1760451732557:281474976710658] at 72075186224037903 executing on unit WaitForPlan
2025-10-14T14:22:12.509744Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1760451732557:281474976710658] at 72075186224037903 to execution unit PlanQueue
2025-10-14T14:22:12.509845Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269877761, Sender [1:7561082616359264564:3208], Recipient [1:7561082616359264006:2329]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.509874Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3179: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-14T14:22:12.509891Z node 1 :TX_DATASHARD DEBUG: datashard.cpp:3721: Server connected at leader tablet# 72075186224037896, clientId# [1:7561082616359264543:3187], serverId# [1:7561082616359264564:3208], sessionId# [0:0:0]
2025-10-14T14:22:12.509936Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269287424, Sender [1:7561082603474361450:2382], Recipient [1:7561082616359264006:2329]: {TEvPlanStep step# 1760451732557 MediatorId# 72057594046382081 TabletID 72075186224037896}
2025-10-14T14:22:12.509947Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3161: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-10-14T14:22:12.510026Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1806: Trying to execute [1760451732557:281474976710658] at 72075186224037896 on unit WaitForPlan
2025-10-14T14:22:12.510036Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1821: Execution status for [1760451732557:281474976710658] at 72075186224037896 is Executed
2025-10-14T14:22:12.510057Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1760451732557:281474976710658] at 72075186224037896 executing on unit WaitForPlan
2025-10-14T14:22:12.510073Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1760451732557:281474976710658] at 72075186224037896 to execution unit PlanQueue
2025-10-14T14:22:12.513461Z node 1 :TX_DATASHARD DEBUG: datashard__plan_step.cpp:69: Planned transaction txId 281474976710658 at step 1760451732557 at tablet 72075186224037903 { Transactions { TxId: 281474976710658 AckTo { RawX1: 0 RawX2: 0 } } Step: 1760451732557 MediatorID: 72057594046382081 TabletID: 72075186224037903 }
2025-10-14T14:22:12.513478Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037903
2025-10-14T14:22:12.513626Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359264009:2331]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.513646Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037903
2025-10-14T14:22:12.513735Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359264009:2331], Recipient [1:7561082616359264009:2331]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.513749Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.513786Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037903
2025-10-14T14:22:12.513808Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037903 active 0 active planned 0 immediate 0 planned 1
2025-10-14T14:22:12.513824Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037903
2025-10-14T14:22:12.513841Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:333: Found ready operation [1760451732557:281474976710658] in PlanQueue unit at 72075186224037903
2025-10-14T14:22:12.513864Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1760451732557:281474976710658] at 72075186224037903 on unit PlanQueue
2025-10-14T14:22:12.513881Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1760451732557:281474976710658] at 72075186224037903 is Executed
2025-10-14T14:22:12.513898Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1760451732557:281474976710658] at 72075186224037903 executing on unit PlanQueue
2025-10-14T14:22:12.513911Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1760451732557:281474976710658] at 72075186224037903 to execution unit LoadTxDetails
2025-10-14T14:22:12.513949Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1760451732557:281474976710658] at 72075186224037903 on unit LoadTxDetails
2025-10-14T14:22:12.513977Z node 1 :TX_DATASHARD DEBUG: datashard__plan_step.cpp:69: Planned transaction txId 281474976710658 at step 1760451732557 at tablet 72075186224037896 { Transactions { TxId: 281474976710658 AckTo { RawX1: 0 RawX2: 0 } } Step: 1760451732557 MediatorID: 72057594046382081 TabletID: 72075186224037896 }
2025-10-14T14:22:12.513993Z node 1 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037896
2025-10-14T14:22:12.514138Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 269746185, Sender [1:7561082616359264418:3083], Recipient [1:7561082616359264006:2329]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-10-14T14:22:12.514159Z node 1 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:129: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037896
2025-10-14T14:22:12.514210Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:634: LoadTxDetails at 72075186224037903 loaded tx from db 1760451732557:281474976710658 keys extracted: 0
2025-10-14T14:22:12.514220Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1760451732557:281474976710658] at 72075186224037903 is Executed
2025-10-14T14:22:12.514221Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3143: StateWork, received event# 2146435072, Sender [1:7561082616359264006:2329], Recipient [1:7561082616359264006:2329]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.514229Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1760451732557:281474976710658] at 72075186224037903 executing on unit LoadTxDetails
2025-10-14T14:22:12.514231Z node 1 :TX_DATASHARD TRACE: datashard_impl.h:3168: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-10-14T14:22:12.514236Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1760451732557:281474976710658] at 72075186224037903 to execution unit ProtectSchemeEchoes
2025-10-14T14:22:12.514245Z node 1 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037896
2025-10-14T14:22:12.514249Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1760451732557:281474976710658] at 72075186224037903 on unit ProtectSchemeEchoes
2025-10-14T14:22:12.514270Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037896 active 0 active planned 0 immediate 0 planned 1
2025-10-14T14:22:12.514278Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037896
2025-10-14T14:22:12.514288Z node 1 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:333: Found ready operation [1760451732557:281474976710658] in PlanQueue unit at 72075186224037896
2025-10-14T14:22:12.514294Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1760451732557:281474976710658] at 72075186224037896 on unit PlanQueue
2025-10-14T14:22:12.514297Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1760451732557:281474976710658] at 72075186224037903 is ExecutedNoMoreRestarts
2025-10-14T14:22:12.514307Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1760451732557:281474976710658] at 72075186224037896 is Executed
2025-10-14T14:22:12.514321Z node 1 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1760451732557:281474976710658] at 72075186224037896 executing on unit PlanQueue
