test_client.cpp: SetPath # /home/runner/.ya/build/build_root/av6y/000e22/r3tmp/tmp63uqkX/pdisk_1.dat
2025-12-09T04:01:01.454193Z node 7 :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-12-09T04:01:01.454256Z node 7 :METADATA_PROVIDER ERROR: log.cpp:841: fline=accessor_snapshot_base.cpp:71;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=incorrect path status: LookupError;
2025-12-09T04:01:01.468252Z node 7 :IMPORT WARN: schemeshard_import.cpp:307: Table profiles were not loaded
TServer::EnableGrpc on GrpcPort 30856, node 7
2025-12-09T04:01:01.482365Z node 7 :NET_CLASSIFIER WARN: net_classifier.cpp:190: distributable config is empty, broken or outdated, will use file: (empty maybe)
2025-12-09T04:01:01.482377Z node 7 :NET_CLASSIFIER WARN: net_classifier.cpp:196: will try to initialize from file: (empty maybe)
2025-12-09T04:01:01.482379Z node 7 :NET_CLASSIFIER WARN: net_classifier.cpp:204: failed to initialize from file: (empty maybe)
2025-12-09T04:01:01.482396Z node 7 :NET_CLASSIFIER ERROR: net_classifier.cpp:228: got bad distributable configuration
TClient is connected to server localhost:13183
WaitRootIsUp 'Root'...
TClient::Ls request: Root
2025-12-09T04:01:01.551777Z node 7 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(7, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-12-09T04:01:01.551814Z node 7 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(7, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-12-09T04:01:01.554266Z node 7 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(7, (0,0,0,0)) VolatileState: Connecting -> Connected
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-12-09T04:01:01.558884Z node 7 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 281474976715657:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_alter_subdomain.cpp:311)
waiting...
2025-12-09T04:01:01.594092Z node 7 :GRPC_SERVER INFO: grpc_request_proxy.cpp:646: Got grpc request# ListEndpointsRequest, traceId# 01kc0ma3mp2617ge82y9ksrsxb, sdkBuildInfo# ydb-cpp-sdk/dev, state# AS_NOT_PERFORMED, database# undef, peer# ipv4:127.0.0.1:53504, grpcInfo# grpc-c++/1.54.3 grpc-c/31.0.0 (linux; chttp2), timeout# 9.995908s
2025-12-09T04:01:01.602760Z node 7 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:649: Got grpc request# CreateSessionRequest, traceId# 01kc0ma3n24s63ke57kgzmvr1p, sdkBuildInfo# ydb-cpp-sdk/dev, state# AS_NOT_PERFORMED, database# undef, peer# ipv6:[::1]:39180, grpcInfo# grpc-c++/1.54.3 grpc-c/31.0.0 (linux; chttp2), timeout# undef
2025-12-09T04:01:01.666849Z node 7 :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-12-09T04:01:01.843005Z node 7 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:649: Got grpc request# CreateTableRequest, traceId# 01kc0ma3wj08e91rq4wq4yf8zd, sdkBuildInfo# ydb-cpp-sdk/dev, state# AS_NOT_PERFORMED, database# undef, peer# ipv4:127.0.0.1:53504, grpcInfo# grpc-c++/1.54.3 grpc-c/31.0.0 (linux; chttp2), timeout# undef
2025-12-09T04:01:01.843983Z node 7 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976715658: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:690)
2025-12-09T04:01:01.846806Z node 7 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:543: SchemeBoardUpdate /Root
2025-12-09T04:01:01.846816Z node 7 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:543: SchemeBoardUpdate /Root
2025-12-09T04:01:01.846842Z node 7 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:572: Can't update SecurityState for /Root - no PublicKeys
2025-12-09T04:01:01.846844Z node 7 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:572: Can't update SecurityState for /Root - no PublicKeys
2025-12-09T04:01:01.851986Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828672, Sender [7:7581703308827077797:2631], Recipient [7:7581703308827077879:2319]: NKikimr::TEvTablet::TEvBoot
2025-12-09T04:01:01.852219Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828672, Sender [7:7581703308827077798:2632], Recipient [7:7581703308827077881:2320]: NKikimr::TEvTablet::TEvBoot
2025-12-09T04:01:01.852325Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828672, Sender [7:7581703308827077805:2639], Recipient [7:7581703308827077897:2322]: NKikimr::TEvTablet::TEvBoot
2025-12-09T04:01:01.852443Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828672, Sender [7:7581703308827077802:2636], Recipient [7:7581703308827077900:2324]: NKikimr::TEvTablet::TEvBoot
2025-12-09T04:01:01.852448Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828672, Sender [7:7581703308827077800:2634], Recipient [7:7581703308827077902:2326]: NKikimr::TEvTablet::TEvBoot
2025-12-09T04:01:01.852550Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828672, Sender [7:7581703308827077796:2630], Recipient [7:7581703308827077898:2323]: NKikimr::TEvTablet::TEvBoot
2025-12-09T04:01:01.852562Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828672, Sender [7:7581703308827077801:2635], Recipient [7:7581703308827077896:2321]: NKikimr::TEvTablet::TEvBoot
2025-12-09T04:01:01.852636Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828672, Sender [7:7581703308827077803:2637], Recipient [7:7581703308827077903:2327]: NKikimr::TEvTablet::TEvBoot
2025-12-09T04:01:01.852662Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828672, Sender [7:7581703308827077804:2638], Recipient [7:7581703308827077911:2328]: NKikimr::TEvTablet::TEvBoot
2025-12-09T04:01:01.852692Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828672, Sender [7:7581703308827077799:2633], Recipient [7:7581703308827077901:2325]: NKikimr::TEvTablet::TEvBoot
2025-12-09T04:01:01.853238Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828673, Sender [7:7581703308827077797:2631], Recipient [7:7581703308827077879:2319]: NKikimr::TEvTablet::TEvRestored
2025-12-09T04:01:01.853386Z node 7 :TX_DATASHARD INFO: datashard.cpp:372: TDataShard::OnActivateExecutor: tablet 72075186224037889 actor [7:7581703308827077879:2319]
2025-12-09T04:01:01.853436Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-12-09T04:01:01.853756Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828673, Sender [7:7581703308827077798:2632], Recipient [7:7581703308827077881:2320]: NKikimr::TEvTablet::TEvRestored
2025-12-09T04:01:01.853821Z node 7 :TX_DATASHARD INFO: datashard.cpp:372: TDataShard::OnActivateExecutor: tablet 72075186224037891 actor [7:7581703308827077881:2320]
2025-12-09T04:01:01.853853Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-12-09T04:01:01.854538Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3123: StateInactive, received event# 268828684, Sender [7:7581703308827077797:2631], Recipient [7:7581703308827077879:2319]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-12-09T04:01:01.854874Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3123: StateInactive, received event# 268828684, Sender [7:7581703308827077798:2632], Recipient [7:7581703308827077881:2320]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-12-09T04:01:01.856924Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828673, Sender [7:7581703308827077796:2630], Recipient [7:7581703308827077898:2323]: NKikimr::TEvTablet::TEvRestored
2025-12-09T04:01:01.856950Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828673, Sender [7:7581703308827077801:2635], Recipient [7:7581703308827077896:2321]: NKikimr::TEvTablet::TEvRestored
2025-12-09T04:01:01.857046Z node 7 :TX_DATASHARD INFO: datashard.cpp:372: TDataShard::OnActivateExecutor: tablet 72075186224037888 actor [7:7581703308827077898:2323]
2025-12-09T04:01:01.857067Z node 7 :TX_DATASHARD INFO: datashard.cpp:372: TDataShard::OnActivateExecutor: tablet 72075186224037896 actor [7:7581703308827077896:2321]
2025-12-09T04:01:01.857090Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-12-09T04:01:01.857114Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-12-09T04:01:01.858303Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3123: StateInactive, received event# 268828684, Sender [7:7581703308827077796:2630], Recipient [7:7581703308827077898:2323]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-12-09T04:01:01.858331Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828673, Sender [7:7581703308827077805:2639], Recipient [7:7581703308827077897:2322]: NKikimr::TEvTablet::TEvRestored
2025-12-09T04:01:01.858359Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3123: StateInactive, received event# 268828684, Sender [7:7581703308827077801:2635], Recipient [7:7581703308827077896:2321]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-12-09T04:01:01.858384Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828673, Sender [7:7581703308827077804:2638], Recipient [7:7581703308827077911:2328]: NKikimr::TEvTablet::TEvRestored
2025-12-09T04:01:01.858410Z node 7 :TX_DATASHARD INFO: datashard.cpp:372: TDataShard::OnActivateExecutor: tablet 72075186224037890 actor [7:7581703308827077897:2322]
2025-12-09T04:01:01.858449Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-12-09T04:01:01.858459Z node 7 :TX_DATASHARD INFO: datashard.cpp:372: TDataShard::OnActivateExecutor: tablet 72075186224037892 actor [7:7581703308827077911:2328]
2025-12-09T04:01:01.858498Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-12-09T04:01:01.859471Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3123: StateInactive, received event# 268828684, Sender [7:7581703308827077805:2639], Recipient [7:7581703308827077897:2322]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-12-09T04:01:01.859496Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828673, Sender [7:7581703308827077803:2637], Recipient [7:7581703308827077903:2327]: NKikimr::TEvTablet::TEvRestored
2025-12-09T04:01:01.859497Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3123: StateInactive, received event# 268828684, Sender [7:7581703308827077804:2638], Recipient [7:7581703308827077911:2328]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-12-09T04:01:01.859513Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828673, Sender [7:7581703308827077802:2636], Recipient [7:7581703308827077900:2324]: NKikimr::TEvTablet::TEvRestored
2025-12-09T04:01:01.859565Z node 7 :TX_DATASHARD INFO: datashard.cpp:372: TDataShard::OnActivateExecutor: tablet 72075186224037893 actor [7:7581703308827077903:2327]
2025-12-09T04:01:01.859574Z node 7 :TX_DATASHARD INFO: datashard.cpp:372: TDataShard::OnActivateExecutor: tablet 72075186224037894 actor [7:7581703308827077900:2324]
2025-12-09T04:01:01.859608Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-12-09T04:01:01.859608Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-12-09T04:01:01.860572Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3123: StateInactive, received event# 268828684, Sender [7:7581703308827077802:2636], Recipient [7:7581703308827077900:2324]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-12-09T04:01:01.860584Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3123: StateInactive, received event# 268828684, Sender [7:7581703308827077803:2637], Recipient [7:7581703308827077903:2327]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-12-09T04:01:01.860590Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828673, Sender [7:7581703308827077799:2633], Recipient [7:7581703308827077901:2325]: NKikimr::TEvTablet::TEvRestored
2025-12-09T04:01:01.860600Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3110: StateInit, received event# 268828673, Sender [7:7581703308827077800:2634], Recipient [7:7581703308827077902:2326]: NKikimr::TEvTablet::TEvRestored
2025-12-09T04:01:01.860657Z node 7 :TX_DATASHARD INFO: datashard.cpp:372: TDataShard::OnActivateExecutor: tablet 72075186224037895 actor [7:7581703308827077901:2325]
2025-12-09T04:01:01.860657Z node 7 :TX_DATASHARD INFO: datashard.cpp:372: TDataShard::OnActivateExecutor: tablet 72075186224037897 actor [7:7581703308827077902:2326]
2025-12-09T04:01:01.860691Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-12-09T04:01:01.860691Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:661: TxInitSchema.Execute
2025-12-09T04:01:01.861680Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3123: StateInactive, received event# 268828684, Sender [7:7581703308827077799:2633], Recipient [7:7581703308827077901:2325]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-12-09T04:01:01.861687Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3123: StateInactive, received event# 268828684, Sender [7:7581703308827077800:2634], Recipient [7:7581703308827077902:2326]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-12-09T04:01:01.861708Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-12-09T04:01:01.861712Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-12-09T04:01:01.861719Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-12-09T04:01:01.861722Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-12-09T04:01:01.861886Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1322: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037889
2025-12-09T04:01:01.861887Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1322: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037891
2025-12-09T04:01:01.861892Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1378: LoadLockChangeRecords at tablet: 72075186224037891
2025-12-09T04:01:01.861893Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1378: LoadLockChangeRecords at tablet: 72075186224037889
2025-12-09T04:01:01.861897Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1427: LoadChangeRecordCommits at tablet: 72075186224037891
2025-12-09T04:01:01.861898Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1427: LoadChangeRecordCommits at tablet: 72075186224037889
2025-12-09T04:01:01.861949Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-12-09T04:01:01.861950Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-12-09T04:01:01.861955Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-12-09T04:01:01.861955Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-12-09T04:01:01.861961Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037891 persisting started state actor id [7:7581703308827078134:2320] in generation 1
2025-12-09T04:01:01.861961Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037889 persisting started state actor id [7:7581703308827078133:2319] in generation 1
2025-12-09T04:01:01.862028Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-12-09T04:01:01.862037Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-12-09T04:01:01.862095Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-12-09T04:01:01.862105Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-12-09T04:01:01.862175Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1322: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037896
2025-12-09T04:01:01.862179Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1378: LoadLockChangeRecords at tablet: 72075186224037896
2025-12-09T04:01:01.862183Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1427: LoadChangeRecordCommits at tablet: 72075186224037896
2025-12-09T04:01:01.862216Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-12-09T04:01:01.862221Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-12-09T04:01:01.862225Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037896 persisting started state actor id [7:7581703308827078135:2321] in generation 1
2025-12-09T04:01:01.862232Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1322: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037888
2025-12-09T04:01:01.862237Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1378: LoadLockChangeRecords at tablet: 72075186224037888
2025-12-09T04:01:01.862242Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1427: LoadChangeRecordCommits at tablet: 72075186224037888
2025-12-09T04:01:01.862247Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-12-09T04:01:01.862255Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-12-09T04:01:01.862275Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-12-09T04:01:01.862279Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-12-09T04:01:01.862282Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037888 persisting started state actor id [7:7581703308827078136:2323] in generation 1
2025-12-09T04:01:01.862314Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-12-09T04:01:01.862322Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-12-09T04:01:01.862376Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1322: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037890
2025-12-09T04:01:01.862380Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1378: LoadLockChangeRecords at tablet: 72075186224037890
2025-12-09T04:01:01.862384Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1427: LoadChangeRecordCommits at tablet: 72075186224037890
2025-12-09T04:01:01.862420Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-12-09T04:01:01.862427Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-12-09T04:01:01.862430Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037890 persisting started state actor id [7:7581703308827078137:2322] in generation 1
2025-12-09T04:01:01.862452Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-12-09T04:01:01.862457Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1322: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037892
2025-12-09T04:01:01.862459Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-12-09T04:01:01.862461Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1378: LoadLockChangeRecords at tablet: 72075186224037892
2025-12-09T04:01:01.862465Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1427: LoadChangeRecordCommits at tablet: 72075186224037892
2025-12-09T04:01:01.862494Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-12-09T04:01:01.862498Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-12-09T04:01:01.862501Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037892 persisting started state actor id [7:7581703308827078138:2328] in generation 1
2025-12-09T04:01:01.862520Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-12-09T04:01:01.862527Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-12-09T04:01:01.862574Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1322: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037893
2025-12-09T04:01:01.862578Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1378: LoadLockChangeRecords at tablet: 72075186224037893
2025-12-09T04:01:01.862581Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1427: LoadChangeRecordCommits at tablet: 72075186224037893
2025-12-09T04:01:01.862610Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-12-09T04:01:01.862614Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-12-09T04:01:01.862616Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037893 persisting started state actor id [7:7581703308827078139:2327] in generation 1
2025-12-09T04:01:01.862637Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1322: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037894
2025-12-09T04:01:01.862641Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1378: LoadLockChangeRecords at tablet: 72075186224037894
2025-12-09T04:01:01.862646Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1427: LoadChangeRecordCommits at tablet: 72075186224037894
2025-12-09T04:01:01.862672Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-12-09T04:01:01.862676Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-12-09T04:01:01.862678Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037894 persisting started state actor id [7:7581703308827078140:2324] in generation 1
2025-12-09T04:01:01.866020Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-12-09T04:01:01.866036Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-12-09T04:01:01.866186Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1322: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037895
2025-12-09T04:01:01.866191Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1378: LoadLockChangeRecords at tablet: 72075186224037895
2025-12-09T04:01:01.866196Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1427: LoadChangeRecordCommits at tablet: 72075186224037895
2025-12-09T04:01:01.866256Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-12-09T04:01:01.866262Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-12-09T04:01:01.866268Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037895 persisting started state actor id [7:7581703308827078164:2325] in generation 1
2025-12-09T04:01:01.866271Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:727: TxInitSchema.Complete
2025-12-09T04:01:01.866281Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:50: TDataShard::TTxInit::Execute
2025-12-09T04:01:01.866294Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-12-09T04:01:01.866302Z node 7 :TX_DATASHARD INFO: datashard.cpp:416: Switched to work state WaitScheme tabletId 72075186224037890
2025-12-09T04:01:01.866318Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:456: 72075186224037890 not sending time cast registration request in state WaitScheme: missing processing params
2025-12-09T04:01:01.866327Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1257: Change sender created: at tablet: 72075186224037890, actorId: [7:7581703308827078166:2329]
2025-12-09T04:01:01.866331Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1262: Trying to activate change sender: at tablet: 72075186224037890
2025-12-09T04:01:01.866334Z node 7 :TX_DATASHARD INFO: datashard.cpp:1279: Cannot activate change sender: at tablet: 72075186224037890, state: WaitScheme
2025-12-09T04:01:01.866344Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037890
2025-12-09T04:01:01.866360Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077897:2322], Recipient [7:7581703308827077897:2322]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866363Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866375Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037890
2025-12-09T04:01:01.866382Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037890
2025-12-09T04:01:01.866386Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037890
2025-12-09T04:01:01.866391Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037890 active 0 active planned 0 immediate 0 planned 0
2025-12-09T04:01:01.866396Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037890
2025-12-09T04:01:01.866400Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037890 has no attached operations
2025-12-09T04:01:01.866402Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037890
2025-12-09T04:01:01.866406Z node 7 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037890 TxInFly 0
2025-12-09T04:01:01.866408Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037890
2025-12-09T04:01:01.866415Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827077996:2768], Recipient [7:7581703308827077897:2322]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.866415Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1322: LoadChangeRecords: QueueSize: 0, at tablet: 72075186224037897
2025-12-09T04:01:01.866418Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.866419Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1378: LoadLockChangeRecords at tablet: 72075186224037897
2025-12-09T04:01:01.866424Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037890, clientId# [7:7581703308827077943:2725], serverId# [7:7581703308827077996:2768], sessionId# [0:0:0]
2025-12-09T04:01:01.866424Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1427: LoadChangeRecordCommits at tablet: 72075186224037897
2025-12-09T04:01:01.866430Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-12-09T04:01:01.866433Z node 7 :TX_DATASHARD INFO: datashard.cpp:416: Switched to work state WaitScheme tabletId 72075186224037892
2025-12-09T04:01:01.866439Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:456: 72075186224037892 not sending time cast registration request in state WaitScheme: missing processing params
2025-12-09T04:01:01.866445Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1257: Change sender created: at tablet: 72075186224037892, actorId: [7:7581703308827078167:2330]
2025-12-09T04:01:01.866446Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1262: Trying to activate change sender: at tablet: 72075186224037892
2025-12-09T04:01:01.866447Z node 7 :TX_DATASHARD INFO: datashard.cpp:1279: Cannot activate change sender: at tablet: 72075186224037892, state: WaitScheme
2025-12-09T04:01:01.866449Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037892
2025-12-09T04:01:01.866456Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077911:2328], Recipient [7:7581703308827077911:2328]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866458Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866465Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037892
2025-12-09T04:01:01.866468Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:94: TDataShard::TTxInit::Complete
2025-12-09T04:01:01.866471Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037892
2025-12-09T04:01:01.866472Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:102: TDataShard::TTxInitRestored::Execute
2025-12-09T04:01:01.866474Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037892
2025-12-09T04:01:01.866475Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037892 active 0 active planned 0 immediate 0 planned 0
2025-12-09T04:01:01.866476Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:142: DataShard 72075186224037897 persisting started state actor id [7:7581703308827078168:2326] in generation 1
2025-12-09T04:01:01.866477Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037892
2025-12-09T04:01:01.866478Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037892 has no attached operations
2025-12-09T04:01:01.866479Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037892
2025-12-09T04:01:01.866480Z node 7 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037892 TxInFly 0
2025-12-09T04:01:01.866482Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037892
2025-12-09T04:01:01.866488Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-12-09T04:01:01.866492Z node 7 :TX_DATASHARD INFO: datashard.cpp:416: Switched to work state WaitScheme tabletId 72075186224037893
2025-12-09T04:01:01.866496Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-12-09T04:01:01.866504Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:456: 72075186224037893 not sending time cast registration request in state WaitScheme: missing processing params
2025-12-09T04:01:01.866506Z node 7 :TX_DATASHARD INFO: datashard.cpp:416: Switched to work state WaitScheme tabletId 72075186224037888
2025-12-09T04:01:01.866507Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1257: Change sender created: at tablet: 72075186224037893, actorId: [7:7581703308827078169:2331]
2025-12-09T04:01:01.866508Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1262: Trying to activate change sender: at tablet: 72075186224037893
2025-12-09T04:01:01.866510Z node 7 :TX_DATASHARD INFO: datashard.cpp:1279: Cannot activate change sender: at tablet: 72075186224037893, state: WaitScheme
2025-12-09T04:01:01.866512Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037893
2025-12-09T04:01:01.866514Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:456: 72075186224037888 not sending time cast registration request in state WaitScheme: missing processing params
2025-12-09T04:01:01.866517Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1257: Change sender created: at tablet: 72075186224037888, actorId: [7:7581703308827078170:2332]
2025-12-09T04:01:01.866519Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077903:2327], Recipient [7:7581703308827077903:2327]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866519Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1262: Trying to activate change sender: at tablet: 72075186224037888
2025-12-09T04:01:01.866521Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866521Z node 7 :TX_DATASHARD INFO: datashard.cpp:1279: Cannot activate change sender: at tablet: 72075186224037888, state: WaitScheme
2025-12-09T04:01:01.866522Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037888
2025-12-09T04:01:01.866528Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037893
2025-12-09T04:01:01.866532Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077898:2323], Recipient [7:7581703308827077898:2323]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866534Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037893
2025-12-09T04:01:01.866534Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866536Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037893
2025-12-09T04:01:01.866538Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037893 active 0 active planned 0 immediate 0 planned 0
2025-12-09T04:01:01.866539Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037893
2025-12-09T04:01:01.866541Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037893 has no attached operations
2025-12-09T04:01:01.866542Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037888
2025-12-09T04:01:01.866542Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037893
2025-12-09T04:01:01.866543Z node 7 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037893 TxInFly 0
2025-12-09T04:01:01.866545Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037893
2025-12-09T04:01:01.866550Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827077985:2757], Recipient [7:7581703308827077903:2327]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.866553Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.866555Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037893, clientId# [7:7581703308827077948:2730], serverId# [7:7581703308827077985:2757], sessionId# [0:0:0]
2025-12-09T04:01:01.866561Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-12-09T04:01:01.866562Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037888
2025-12-09T04:01:01.866564Z node 7 :TX_DATASHARD INFO: datashard.cpp:416: Switched to work state WaitScheme tabletId 72075186224037891
2025-12-09T04:01:01.866565Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037888
2025-12-09T04:01:01.866567Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037888 active 0 active planned 0 immediate 0 planned 0
2025-12-09T04:01:01.866569Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037888
2025-12-09T04:01:01.866570Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:456: 72075186224037891 not sending time cast registration request in state WaitScheme: missing processing params
2025-12-09T04:01:01.866570Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037888 has no attached operations
2025-12-09T04:01:01.866572Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037888
2025-12-09T04:01:01.866573Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1257: Change sender created: at tablet: 72075186224037891, actorId: [7:7581703308827078171:2333]
2025-12-09T04:01:01.866573Z node 7 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037888 TxInFly 0
2025-12-09T04:01:01.866574Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1262: Trying to activate change sender: at tablet: 72075186224037891
2025-12-09T04:01:01.866575Z node 7 :TX_DATASHARD INFO: datashard.cpp:1279: Cannot activate change sender: at tablet: 72075186224037891, state: WaitScheme
2025-12-09T04:01:01.866576Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037888
2025-12-09T04:01:01.866577Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037891
2025-12-09T04:01:01.866582Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827077993:2765], Recipient [7:7581703308827077898:2323]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.866583Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077881:2320], Recipient [7:7581703308827077881:2320]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866584Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.866585Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866587Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037888, clientId# [7:7581703308827077937:2719], serverId# [7:7581703308827077993:2765], sessionId# [0:0:0]
2025-12-09T04:01:01.866592Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037891
2025-12-09T04:01:01.866593Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-12-09T04:01:01.866596Z node 7 :TX_DATASHARD INFO: datashard.cpp:416: Switched to work state WaitScheme tabletId 72075186224037896
2025-12-09T04:01:01.866602Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:456: 72075186224037896 not sending time cast registration request in state WaitScheme: missing processing params
2025-12-09T04:01:01.866605Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1257: Change sender created: at tablet: 72075186224037896, actorId: [7:7581703308827078172:2334]
2025-12-09T04:01:01.866606Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1262: Trying to activate change sender: at tablet: 72075186224037896
2025-12-09T04:01:01.866607Z node 7 :TX_DATASHARD INFO: datashard.cpp:1279: Cannot activate change sender: at tablet: 72075186224037896, state: WaitScheme
2025-12-09T04:01:01.866608Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037896
2025-12-09T04:01:01.866610Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037891
2025-12-09T04:01:01.866613Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037891
2025-12-09T04:01:01.866615Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077896:2321], Recipient [7:7581703308827077896:2321]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866617Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866619Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037891 active 0 active planned 0 immediate 0 planned 0
2025-12-09T04:01:01.866620Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037891
2025-12-09T04:01:01.866622Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037891 has no attached operations
2025-12-09T04:01:01.866623Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037891
2025-12-09T04:01:01.866624Z node 7 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037891 TxInFly 0
2025-12-09T04:01:01.866627Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037891
2025-12-09T04:01:01.866631Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037896
2025-12-09T04:01:01.866632Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-12-09T04:01:01.866634Z node 7 :TX_DATASHARD INFO: datashard.cpp:416: Switched to work state WaitScheme tabletId 72075186224037889
2025-12-09T04:01:01.866637Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037896
2025-12-09T04:01:01.866640Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037896
2025-12-09T04:01:01.866640Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:456: 72075186224037889 not sending time cast registration request in state WaitScheme: missing processing params
2025-12-09T04:01:01.866641Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037896 active 0 active planned 0 immediate 0 planned 0
2025-12-09T04:01:01.866643Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037896
2025-12-09T04:01:01.866644Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037896 has no attached operations
2025-12-09T04:01:01.866645Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1257: Change sender created: at tablet: 72075186224037889, actorId: [7:7581703308827078173:2335]
2025-12-09T04:01:01.866646Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037896
2025-12-09T04:01:01.866646Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1262: Trying to activate change sender: at tablet: 72075186224037889
2025-12-09T04:01:01.866647Z node 7 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037896 TxInFly 0
2025-12-09T04:01:01.866648Z node 7 :TX_DATASHARD INFO: datashard.cpp:1279: Cannot activate change sender: at tablet: 72075186224037889, state: WaitScheme
2025-12-09T04:01:01.866649Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037889
2025-12-09T04:01:01.866649Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037896
2025-12-09T04:01:01.866654Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827077986:2758], Recipient [7:7581703308827077896:2321]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.866656Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077879:2319], Recipient [7:7581703308827077879:2319]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866656Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.866658Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866659Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037896, clientId# [7:7581703308827077951:2733], serverId# [7:7581703308827077986:2758], sessionId# [0:0:0]
2025-12-09T04:01:01.866663Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-12-09T04:01:01.866665Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037889
2025-12-09T04:01:01.866666Z node 7 :TX_DATASHARD INFO: datashard.cpp:416: Switched to work state WaitScheme tabletId 72075186224037894
2025-12-09T04:01:01.866671Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:456: 72075186224037894 not sending time cast registration request in state WaitScheme: missing processing params
2025-12-09T04:01:01.866672Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037889
2025-12-09T04:01:01.866674Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1257: Change sender created: at tablet: 72075186224037894, actorId: [7:7581703308827078174:2336]
2025-12-09T04:01:01.866675Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1262: Trying to activate change sender: at tablet: 72075186224037894
2025-12-09T04:01:01.866677Z node 7 :TX_DATASHARD INFO: datashard.cpp:1279: Cannot activate change sender: at tablet: 72075186224037894, state: WaitScheme
2025-12-09T04:01:01.866678Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037894
2025-12-09T04:01:01.866685Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037889
2025-12-09T04:01:01.866686Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037889 active 0 active planned 0 immediate 0 planned 0
2025-12-09T04:01:01.866688Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037889
2025-12-09T04:01:01.866689Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037889 has no attached operations
2025-12-09T04:01:01.866690Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037889
2025-12-09T04:01:01.866692Z node 7 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037889 TxInFly 0
2025-12-09T04:01:01.866693Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077900:2324], Recipient [7:7581703308827077900:2324]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866694Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037889
2025-12-09T04:01:01.866695Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.866699Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269549568, Sender [7:7581703308827077174:2212], Recipient [7:7581703308827077996:2768]
2025-12-09T04:01:01.866702Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3150: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-12-09T04:01:01.866702Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037894
2025-12-09T04:01:01.866709Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037894
2025-12-09T04:01:01.866711Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037894
2025-12-09T04:01:01.866713Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037894 active 0 active planned 0 immediate 0 planned 0
2025-12-09T04:01:01.866714Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037894
2025-12-09T04:01:01.866717Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037894 has no attached operations
2025-12-09T04:01:01.866718Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037894
2025-12-09T04:01:01.866719Z node 7 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037894 TxInFly 0
2025-12-09T04:01:01.866721Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037894
2025-12-09T04:01:01.866721Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037890
2025-12-09T04:01:01.866726Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827077971:2743], Recipient [7:7581703308827077900:2324]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.866727Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.866730Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037894, clientId# [7:7581703308827077949:2731], serverId# [7:7581703308827077971:2743], sessionId# [0:0:0]
2025-12-09T04:01:01.866740Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827077983:2755], Recipient [7:7581703308827077911:2328]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.866741Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.866743Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037892, clientId# [7:7581703308827077947:2729], serverId# [7:7581703308827077983:2755], sessionId# [0:0:0]
2025-12-09T04:01:01.866746Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269549568, Sender [7:7581703308827077174:2212], Recipient [7:7581703308827077983:2755]
2025-12-09T04:01:01.866747Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3150: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-12-09T04:01:01.866755Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037892
2025-12-09T04:01:01.866783Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037892 on unit CheckSchemeTx
2025-12-09T04:01:01.866783Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037890 on unit CheckSchemeTx
2025-12-09T04:01:01.866792Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037892 txId 281474976715658 ssId 72057594046644480 seqNo 2:1
2025-12-09T04:01:01.866792Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037890 txId 281474976715658 ssId 72057594046644480 seqNo 2:1
2025-12-09T04:01:01.866804Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976715658 at tablet 72075186224037890
2025-12-09T04:01:01.866804Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976715658 at tablet 72075186224037892
2025-12-09T04:01:01.866811Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037892 is ExecutedNoMoreRestarts
2025-12-09T04:01:01.866811Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037890 is ExecutedNoMoreRestarts
2025-12-09T04:01:01.866813Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037892 executing on unit CheckSchemeTx
2025-12-09T04:01:01.866814Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037890 executing on unit CheckSchemeTx
2025-12-09T04:01:01.866817Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037892 to execution unit StoreSchemeTx
2025-12-09T04:01:01.866819Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037892 on unit StoreSchemeTx
2025-12-09T04:01:01.866821Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037890 to execution unit StoreSchemeTx
2025-12-09T04:01:01.866823Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037890 on unit StoreSchemeTx
2025-12-09T04:01:01.866864Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037892 is DelayCompleteNoMoreRestarts
2025-12-09T04:01:01.866865Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037890 is DelayCompleteNoMoreRestarts
2025-12-09T04:01:01.866866Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037890 executing on unit StoreSchemeTx
2025-12-09T04:01:01.866866Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037892 executing on unit StoreSchemeTx
2025-12-09T04:01:01.866869Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037890 to execution unit FinishPropose
2025-12-09T04:01:01.866869Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037892 to execution unit FinishPropose
2025-12-09T04:01:01.866870Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037890 on unit FinishPropose
2025-12-09T04:01:01.866871Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037892 on unit FinishPropose
2025-12-09T04:01:01.866876Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037892 is DelayComplete
2025-12-09T04:01:01.866876Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037890 is DelayComplete
2025-12-09T04:01:01.866878Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037892 executing on unit FinishPropose
2025-12-09T04:01:01.866878Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037890 executing on unit FinishPropose
2025-12-09T04:01:01.866880Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037890 to execution unit WaitForPlan
2025-12-09T04:01:01.866880Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037892 to execution unit WaitForPlan
2025-12-09T04:01:01.866882Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037892 on unit WaitForPlan
2025-12-09T04:01:01.866882Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037890 on unit WaitForPlan
2025-12-09T04:01:01.866885Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976715658] at 72075186224037892 is not ready to execute on unit WaitForPlan
2025-12-09T04:01:01.866885Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976715658] at 72075186224037890 is not ready to execute on unit WaitForPlan
2025-12-09T04:01:01.866905Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269549568, Sender [7:7581703308827077174:2212], Recipient [7:7581703308827077993:2765]
2025-12-09T04:01:01.866906Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3150: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-12-09T04:01:01.866913Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037888
2025-12-09T04:01:01.866917Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269549568, Sender [7:7581703308827077174:2212], Recipient [7:7581703308827077985:2757]
2025-12-09T04:01:01.866919Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3150: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-12-09T04:01:01.866925Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037893
2025-12-09T04:01:01.866929Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037888 on unit CheckSchemeTx
2025-12-09T04:01:01.866931Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037888 txId 281474976715658 ssId 72057594046644480 seqNo 2:1
2025-12-09T04:01:01.866941Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037893 on unit CheckSchemeTx
2025-12-09T04:01:01.866943Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037893 txId 281474976715658 ssId 72057594046644480 seqNo 2:1
2025-12-09T04:01:01.866944Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976715658 at tablet 72075186224037888
2025-12-09T04:01:01.866947Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037888 is ExecutedNoMoreRestarts
2025-12-09T04:01:01.866953Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976715658 at tablet 72075186224037893
2025-12-09T04:01:01.866955Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037888 executing on unit CheckSchemeTx
2025-12-09T04:01:01.866955Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037893 is ExecutedNoMoreRestarts
2025-12-09T04:01:01.866957Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037893 executing on unit CheckSchemeTx
2025-12-09T04:01:01.866957Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037888 to execution unit StoreSchemeTx
2025-12-09T04:01:01.866958Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037893 to execution unit StoreSchemeTx
2025-12-09T04:01:01.866959Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037888 on unit StoreSchemeTx
2025-12-09T04:01:01.866960Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037893 on unit StoreSchemeTx
2025-12-09T04:01:01.867000Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037888 is DelayCompleteNoMoreRestarts
2025-12-09T04:01:01.867000Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037893 is DelayCompleteNoMoreRestarts
2025-12-09T04:01:01.867001Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037888 executing on unit StoreSchemeTx
2025-12-09T04:01:01.867001Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037893 executing on unit StoreSchemeTx
2025-12-09T04:01:01.867003Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037888 to execution unit FinishPropose
2025-12-09T04:01:01.867003Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037893 to execution unit FinishPropose
2025-12-09T04:01:01.867005Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037893 on unit FinishPropose
2025-12-09T04:01:01.867006Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037888 on unit FinishPropose
2025-12-09T04:01:01.867008Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037893 is DelayComplete
2025-12-09T04:01:01.867010Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037888 is DelayComplete
2025-12-09T04:01:01.867011Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037888 executing on unit FinishPropose
2025-12-09T04:01:01.867013Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037888 to execution unit WaitForPlan
2025-12-09T04:01:01.867014Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037893 executing on unit FinishPropose
2025-12-09T04:01:01.867015Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037888 on unit WaitForPlan
2025-12-09T04:01:01.867016Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037893 to execution unit WaitForPlan
2025-12-09T04:01:01.867016Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976715658] at 72075186224037888 is not ready to execute on unit WaitForPlan
2025-12-09T04:01:01.867017Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037893 on unit WaitForPlan
2025-12-09T04:01:01.867019Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976715658] at 72075186224037893 is not ready to execute on unit WaitForPlan
2025-12-09T04:01:01.867035Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827077982:2754], Recipient [7:7581703308827077881:2320]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.867035Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827077995:2767], Recipient [7:7581703308827077879:2319]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.867037Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.867037Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.867040Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037889, clientId# [7:7581703308827077939:2721], serverId# [7:7581703308827077995:2767], sessionId# [0:0:0]
2025-12-09T04:01:01.867040Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037891, clientId# [7:7581703308827077944:2726], serverId# [7:7581703308827077982:2754], sessionId# [0:0:0]
2025-12-09T04:01:01.867043Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269549568, Sender [7:7581703308827077174:2212], Recipient [7:7581703308827077982:2754]
2025-12-09T04:01:01.867043Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269549568, Sender [7:7581703308827077174:2212], Recipient [7:7581703308827077995:2767]
2025-12-09T04:01:01.867045Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3150: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-12-09T04:01:01.867046Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3150: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-12-09T04:01:01.867052Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037891
2025-12-09T04:01:01.867053Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037889
2025-12-09T04:01:01.867066Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037891 on unit CheckSchemeTx
2025-12-09T04:01:01.867066Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037889 on unit CheckSchemeTx
2025-12-09T04:01:01.867068Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037889 txId 281474976715658 ssId 72057594046644480 seqNo 2:1
2025-12-09T04:01:01.867069Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037891 txId 281474976715658 ssId 72057594046644480 seqNo 2:1
2025-12-09T04:01:01.867075Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976715658 at tablet 72075186224037891
2025-12-09T04:01:01.867076Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976715658 at tablet 72075186224037889
2025-12-09T04:01:01.867078Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037891 is ExecutedNoMoreRestarts
2025-12-09T04:01:01.867078Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037889 is ExecutedNoMoreRestarts
2025-12-09T04:01:01.867080Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037891 executing on unit CheckSchemeTx
2025-12-09T04:01:01.867080Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037889 executing on unit CheckSchemeTx
2025-12-09T04:01:01.867081Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037891 to execution unit StoreSchemeTx
2025-12-09T04:01:01.867084Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037889 to execution unit StoreSchemeTx
2025-12-09T04:01:01.867084Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037891 on unit StoreSchemeTx
2025-12-09T04:01:01.867085Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037889 on unit StoreSchemeTx
2025-12-09T04:01:01.867113Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037889 is DelayCompleteNoMoreRestarts
2025-12-09T04:01:01.867115Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037889 executing on unit StoreSchemeTx
2025-12-09T04:01:01.867116Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037889 to execution unit FinishPropose
2025-12-09T04:01:01.867118Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037889 on unit FinishPropose
2025-12-09T04:01:01.867121Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037889 is DelayComplete
2025-12-09T04:01:01.867122Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037891 is DelayCompleteNoMoreRestarts
2025-12-09T04:01:01.867123Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037889 executing on unit FinishPropose
2025-12-09T04:01:01.867124Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037891 executing on unit StoreSchemeTx
2025-12-09T04:01:01.867124Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037889 to execution unit WaitForPlan
2025-12-09T04:01:01.867126Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037889 on unit WaitForPlan
2025-12-09T04:01:01.867127Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976715658] at 72075186224037889 is not ready to execute on unit WaitForPlan
2025-12-09T04:01:01.867130Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037891 to execution unit FinishPropose
2025-12-09T04:01:01.867132Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037891 on unit FinishPropose
2025-12-09T04:01:01.867135Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037891 is DelayComplete
2025-12-09T04:01:01.867137Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037891 executing on unit FinishPropose
2025-12-09T04:01:01.867138Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037891 to execution unit WaitForPlan
2025-12-09T04:01:01.867139Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037891 on unit WaitForPlan
2025-12-09T04:01:01.867141Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976715658] at 72075186224037891 is not ready to execute on unit WaitForPlan
2025-12-09T04:01:01.867150Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269746185, Sender [7:7581703308827078175:2889], Recipient [7:7581703308827077879:2319]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-12-09T04:01:01.867156Z node 7 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:180: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037889
2025-12-09T04:01:01.867156Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269746185, Sender [7:7581703308827078175:2889], Recipient [7:7581703308827077881:2320]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-12-09T04:01:01.867158Z node 7 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:180: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037891
2025-12-09T04:01:01.867165Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269549568, Sender [7:7581703308827077174:2212], Recipient [7:7581703308827077986:2758]
2025-12-09T04:01:01.867165Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269549568, Sender [7:7581703308827077174:2212], Recipient [7:7581703308827077971:2743]
2025-12-09T04:01:01.867166Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3150: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-12-09T04:01:01.867167Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3150: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-12-09T04:01:01.867173Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037896
2025-12-09T04:01:01.867174Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037894
2025-12-09T04:01:01.867187Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037896 on unit CheckSchemeTx
2025-12-09T04:01:01.867187Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037894 on unit CheckSchemeTx
2025-12-09T04:01:01.867189Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037896 txId 281474976715658 ssId 72057594046644480 seqNo 2:1
2025-12-09T04:01:01.867190Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037894 txId 281474976715658 ssId 72057594046644480 seqNo 2:1
2025-12-09T04:01:01.867196Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976715658 at tablet 72075186224037894
2025-12-09T04:01:01.867197Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976715658 at tablet 72075186224037896
2025-12-09T04:01:01.867199Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037896 is ExecutedNoMoreRestarts
2025-12-09T04:01:01.867200Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037894 is ExecutedNoMoreRestarts
2025-12-09T04:01:01.867201Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037896 executing on unit CheckSchemeTx
2025-12-09T04:01:01.867202Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037894 executing on unit CheckSchemeTx
2025-12-09T04:01:01.867202Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037896 to execution unit StoreSchemeTx
2025-12-09T04:01:01.867203Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037894 to execution unit StoreSchemeTx
2025-12-09T04:01:01.867204Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037896 on unit StoreSchemeTx
2025-12-09T04:01:01.867205Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037894 on unit StoreSchemeTx
2025-12-09T04:01:01.867230Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037894 is DelayCompleteNoMoreRestarts
2025-12-09T04:01:01.867232Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037894 executing on unit StoreSchemeTx
2025-12-09T04:01:01.867233Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037894 to execution unit FinishPropose
2025-12-09T04:01:01.867235Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037894 on unit FinishPropose
2025-12-09T04:01:01.867238Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037894 is DelayComplete
2025-12-09T04:01:01.867239Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037894 executing on unit FinishPropose
2025-12-09T04:01:01.867241Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037896 is DelayCompleteNoMoreRestarts
2025-12-09T04:01:01.867241Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037894 to execution unit WaitForPlan
2025-12-09T04:01:01.867242Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037896 executing on unit StoreSchemeTx
2025-12-09T04:01:01.867243Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037894 on unit WaitForPlan
2025-12-09T04:01:01.867244Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037896 to execution unit FinishPropose
2025-12-09T04:01:01.867246Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037896 on unit FinishPropose
2025-12-09T04:01:01.867248Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976715658] at 72075186224037894 is not ready to execute on unit WaitForPlan
2025-12-09T04:01:01.867249Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037896 is DelayComplete
2025-12-09T04:01:01.867250Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037896 executing on unit FinishPropose
2025-12-09T04:01:01.867251Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037896 to execution unit WaitForPlan
2025-12-09T04:01:01.867253Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037896 on unit WaitForPlan
2025-12-09T04:01:01.867256Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976715658] at 72075186224037896 is not ready to execute on unit WaitForPlan
2025-12-09T04:01:01.867263Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269746185, Sender [7:7581703308827078175:2889], Recipient [7:7581703308827077900:2324]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-12-09T04:01:01.867266Z node 7 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:180: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037894
2025-12-09T04:01:01.867272Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269746185, Sender [7:7581703308827078175:2889], Recipient [7:7581703308827077896:2321]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-12-09T04:01:01.867275Z node 7 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:180: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037896
2025-12-09T04:01:01.867282Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269746185, Sender [7:7581703308827078175:2889], Recipient [7:7581703308827077897:2322]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-12-09T04:01:01.867284Z node 7 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:180: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037890
2025-12-09T04:01:01.867291Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269746185, Sender [7:7581703308827078175:2889], Recipient [7:7581703308827077898:2323]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-12-09T04:01:01.867293Z node 7 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:180: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037888
2025-12-09T04:01:01.867294Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269746185, Sender [7:7581703308827078175:2889], Recipient [7:7581703308827077903:2327]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-12-09T04:01:01.867296Z node 7 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:180: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037893
2025-12-09T04:01:01.867308Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269746185, Sender [7:7581703308827078175:2889], Recipient [7:7581703308827077911:2328]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-12-09T04:01:01.867310Z node 7 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:180: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037892
2025-12-09T04:01:01.869709Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037896
2025-12-09T04:01:01.869710Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-12-09T04:01:01.869716Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037896 on unit StoreSchemeTx
2025-12-09T04:01:01.869717Z node 7 :TX_DATASHARD INFO: datashard.cpp:416: Switched to work state WaitScheme tabletId 72075186224037897
2025-12-09T04:01:01.869720Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037896 on unit FinishPropose
2025-12-09T04:01:01.869727Z node 7 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976715658 at tablet 72075186224037896 send to client, exec latency: 0 ms, propose latency: 2 ms, status: PREPARED
2025-12-09T04:01:01.869735Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:456: 72075186224037897 not sending time cast registration request in state WaitScheme: missing processing params
2025-12-09T04:01:01.869736Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:466: 72075186224037896 not sending time cast registration request in state WaitScheme
2025-12-09T04:01:01.869744Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1257: Change sender created: at tablet: 72075186224037897, actorId: [7:7581703308827078204:2337]
2025-12-09T04:01:01.869747Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1262: Trying to activate change sender: at tablet: 72075186224037897
2025-12-09T04:01:01.869750Z node 7 :TX_DATASHARD INFO: datashard.cpp:1279: Cannot activate change sender: at tablet: 72075186224037897, state: WaitScheme
2025-12-09T04:01:01.869753Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037897
2025-12-09T04:01:01.869760Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037891
2025-12-09T04:01:01.869762Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037891 on unit StoreSchemeTx
2025-12-09T04:01:01.869764Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037891 on unit FinishPropose
2025-12-09T04:01:01.869767Z node 7 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976715658 at tablet 72075186224037891 send to client, exec latency: 0 ms, propose latency: 2 ms, status: PREPARED
2025-12-09T04:01:01.869770Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:466: 72075186224037891 not sending time cast registration request in state WaitScheme
2025-12-09T04:01:01.869778Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077902:2326], Recipient [7:7581703308827077902:2326]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.869779Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037893
2025-12-09T04:01:01.869781Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037893 on unit StoreSchemeTx
2025-12-09T04:01:01.869782Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.869783Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037893 on unit FinishPropose
2025-12-09T04:01:01.869785Z node 7 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976715658 at tablet 72075186224037893 send to client, exec latency: 0 ms, propose latency: 2 ms, status: PREPARED
2025-12-09T04:01:01.869788Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:466: 72075186224037893 not sending time cast registration request in state WaitScheme
2025-12-09T04:01:01.869796Z node 7 :TX_DATASHARD DEBUG: datashard__init.cpp:151: TDataShard::TTxInitRestored::Complete
2025-12-09T04:01:01.869798Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037897
2025-12-09T04:01:01.869799Z node 7 :TX_DATASHARD INFO: datashard.cpp:416: Switched to work state WaitScheme tabletId 72075186224037895
2025-12-09T04:01:01.869807Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:456: 72075186224037895 not sending time cast registration request in state WaitScheme: missing processing params
2025-12-09T04:01:01.869812Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1257: Change sender created: at tablet: 72075186224037895, actorId: [7:7581703308827078205:2338]
2025-12-09T04:01:01.869815Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037897
2025-12-09T04:01:01.869815Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:1262: Trying to activate change sender: at tablet: 72075186224037895
2025-12-09T04:01:01.869817Z node 7 :TX_DATASHARD INFO: datashard.cpp:1279: Cannot activate change sender: at tablet: 72075186224037895, state: WaitScheme
2025-12-09T04:01:01.869818Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037895
2025-12-09T04:01:01.869819Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037897
2025-12-09T04:01:01.869823Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037897 active 0 active planned 0 immediate 0 planned 0
2025-12-09T04:01:01.869825Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037897
2025-12-09T04:01:01.869828Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077901:2325], Recipient [7:7581703308827077901:2325]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.869828Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037897 has no attached operations
2025-12-09T04:01:01.869830Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037897
2025-12-09T04:01:01.869830Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.869834Z node 7 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037897 TxInFly 0
2025-12-09T04:01:01.869836Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037897
2025-12-09T04:01:01.869838Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:96: TTxCheckInReadSets::Execute at 72075186224037895
2025-12-09T04:01:01.869843Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827077984:2756], Recipient [7:7581703308827077902:2326]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.869845Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.869848Z node 7 :TX_DATASHARD DEBUG: datashard__cleanup_in_rs.cpp:139: TTxCheckInReadSets::Complete found 0 read sets to remove in 72075186224037895
2025-12-09T04:01:01.869848Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037897, clientId# [7:7581703308827077952:2734], serverId# [7:7581703308827077984:2756], sessionId# [0:0:0]
2025-12-09T04:01:01.869851Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037895
2025-12-09T04:01:01.869852Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037895 active 0 active planned 0 immediate 0 planned 0
2025-12-09T04:01:01.869854Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:385: Check unit PlanQueue at 72075186224037895
2025-12-09T04:01:01.869854Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037894
2025-12-09T04:01:01.869855Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037895 has no attached operations
2025-12-09T04:01:01.869856Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:403: Unit PlanQueue has no ready operations at 72075186224037895
2025-12-09T04:01:01.869857Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037894 on unit StoreSchemeTx
2025-12-09T04:01:01.869858Z node 7 :TX_DATASHARD INFO: datashard__progress_tx.cpp:48: No tx to execute at 72075186224037895 TxInFly 0
2025-12-09T04:01:01.869859Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037894 on unit FinishPropose
2025-12-09T04:01:01.869860Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:119: TTxProgressTransaction::Complete at 72075186224037895
2025-12-09T04:01:01.869862Z node 7 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976715658 at tablet 72075186224037894 send to client, exec latency: 0 ms, propose latency: 2 ms, status: PREPARED
2025-12-09T04:01:01.869865Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037890
2025-12-09T04:01:01.869867Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037890 on unit StoreSchemeTx
2025-12-09T04:01:01.869867Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:466: 72075186224037894 not sending time cast registration request in state WaitScheme
2025-12-09T04:01:01.869869Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037890 on unit FinishPropose
2025-12-09T04:01:01.869876Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037888
2025-12-09T04:01:01.869879Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037888 on unit StoreSchemeTx
2025-12-09T04:01:01.869880Z node 7 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976715658 at tablet 72075186224037890 send to client, exec latency: 0 ms, propose latency: 3 ms, status: PREPARED
2025-12-09T04:01:01.869883Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:466: 72075186224037890 not sending time cast registration request in state WaitScheme
2025-12-09T04:01:01.869886Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037888 on unit FinishPropose
2025-12-09T04:01:01.869890Z node 7 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976715658 at tablet 72075186224037888 send to client, exec latency: 0 ms, propose latency: 2 ms, status: PREPARED
2025-12-09T04:01:01.869892Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037892
2025-12-09T04:01:01.869892Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:466: 72075186224037888 not sending time cast registration request in state WaitScheme
2025-12-09T04:01:01.869895Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037892 on unit StoreSchemeTx
2025-12-09T04:01:01.869897Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037892 on unit FinishPropose
2025-12-09T04:01:01.869900Z node 7 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976715658 at tablet 72075186224037892 send to client, exec latency: 0 ms, propose latency: 3 ms, status: PREPARED
2025-12-09T04:01:01.869900Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037889
2025-12-09T04:01:01.869902Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037889 on unit StoreSchemeTx
2025-12-09T04:01:01.869903Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:466: 72075186224037892 not sending time cast registration request in state WaitScheme
2025-12-09T04:01:01.869903Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037889 on unit FinishPropose
2025-12-09T04:01:01.869906Z node 7 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976715658 at tablet 72075186224037889 send to client, exec latency: 0 ms, propose latency: 2 ms, status: PREPARED
2025-12-09T04:01:01.869909Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:466: 72075186224037889 not sending time cast registration request in state WaitScheme
2025-12-09T04:01:01.869911Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827077978:2750], Recipient [7:7581703308827077901:2325]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.869913Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.869916Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037895, clientId# [7:7581703308827077950:2732], serverId# [7:7581703308827077978:2750], sessionId# [0:0:0]
2025-12-09T04:01:01.869916Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269549568, Sender [7:7581703308827077174:2212], Recipient [7:7581703308827077984:2756]
2025-12-09T04:01:01.869918Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3150: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-12-09T04:01:01.869932Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037897
2025-12-09T04:01:01.869968Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269549568, Sender [7:7581703308827077174:2212], Recipient [7:7581703308827077978:2750]
2025-12-09T04:01:01.869969Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3150: StateWork, processing event TEvDataShard::TEvProposeTransaction
2025-12-09T04:01:01.869972Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037897 on unit CheckSchemeTx
2025-12-09T04:01:01.869977Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:33: TTxProposeTransactionBase::Execute at 72075186224037895
2025-12-09T04:01:01.869978Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037897 txId 281474976715658 ssId 72057594046644480 seqNo 2:1
2025-12-09T04:01:01.870003Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976715658 at tablet 72075186224037897
2025-12-09T04:01:01.870007Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037897 is ExecutedNoMoreRestarts
2025-12-09T04:01:01.870010Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037897 executing on unit CheckSchemeTx
2025-12-09T04:01:01.870012Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037895 on unit CheckSchemeTx
2025-12-09T04:01:01.870012Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037897 to execution unit StoreSchemeTx
2025-12-09T04:01:01.870014Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037897 on unit StoreSchemeTx
2025-12-09T04:01:01.870014Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:133: Propose scheme transaction at tablet 72075186224037895 txId 281474976715658 ssId 72057594046644480 seqNo 2:1
2025-12-09T04:01:01.870023Z node 7 :TX_DATASHARD DEBUG: check_scheme_tx_unit.cpp:221: Prepared scheme transaction txId 281474976715658 at tablet 72075186224037895
2025-12-09T04:01:01.870025Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037895 is ExecutedNoMoreRestarts
2025-12-09T04:01:01.870027Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037895 executing on unit CheckSchemeTx
2025-12-09T04:01:01.870029Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037895 to execution unit StoreSchemeTx
2025-12-09T04:01:01.870031Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037895 on unit StoreSchemeTx
2025-12-09T04:01:01.870056Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037897 is DelayCompleteNoMoreRestarts
2025-12-09T04:01:01.870058Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037897 executing on unit StoreSchemeTx
2025-12-09T04:01:01.870060Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037897 to execution unit FinishPropose
2025-12-09T04:01:01.870062Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037897 on unit FinishPropose
2025-12-09T04:01:01.870062Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037895 is DelayCompleteNoMoreRestarts
2025-12-09T04:01:01.870063Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037895 executing on unit StoreSchemeTx
2025-12-09T04:01:01.870064Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037895 to execution unit FinishPropose
2025-12-09T04:01:01.870067Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037897 is DelayComplete
2025-12-09T04:01:01.870068Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037895 on unit FinishPropose
2025-12-09T04:01:01.870068Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037897 executing on unit FinishPropose
2025-12-09T04:01:01.870070Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037897 to execution unit WaitForPlan
2025-12-09T04:01:01.870071Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [0:281474976715658] at 72075186224037895 is DelayComplete
2025-12-09T04:01:01.870072Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037897 on unit WaitForPlan
2025-12-09T04:01:01.870073Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [0:281474976715658] at 72075186224037895 executing on unit FinishPropose
2025-12-09T04:01:01.870074Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [0:281474976715658] at 72075186224037895 to execution unit WaitForPlan
2025-12-09T04:01:01.870075Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [0:281474976715658] at 72075186224037895 on unit WaitForPlan
2025-12-09T04:01:01.870075Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976715658] at 72075186224037897 is not ready to execute on unit WaitForPlan
2025-12-09T04:01:01.870076Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1848: Operation [0:281474976715658] at 72075186224037895 is not ready to execute on unit WaitForPlan
2025-12-09T04:01:01.870109Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269746185, Sender [7:7581703308827078175:2889], Recipient [7:7581703308827077902:2326]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-12-09T04:01:01.870113Z node 7 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:180: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037897
2025-12-09T04:01:01.870116Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269746185, Sender [7:7581703308827078175:2889], Recipient [7:7581703308827077901:2325]: NKikimr::TEvTxProxySchemeCache::TEvWatchNotifyUpdated
2025-12-09T04:01:01.870119Z node 7 :TX_DATASHARD DEBUG: datashard_subdomain_path_id.cpp:180: Discovered subdomain [OwnerId: 72057594046644480, LocalPathId: 1] state, outOfSpace = 0 at datashard 72075186224037895
2025-12-09T04:01:01.874767Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037895
2025-12-09T04:01:01.874775Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037895 on unit StoreSchemeTx
2025-12-09T04:01:01.874779Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037895 on unit FinishPropose
2025-12-09T04:01:01.874787Z node 7 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976715658 at tablet 72075186224037895 send to client, exec latency: 0 ms, propose latency: 4 ms, status: PREPARED
2025-12-09T04:01:01.874807Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:466: 72075186224037895 not sending time cast registration request in state WaitScheme
2025-12-09T04:01:01.874832Z node 7 :TX_DATASHARD DEBUG: datashard__propose_tx_base.cpp:152: TTxProposeTransactionBase::Complete at 72075186224037897
2025-12-09T04:01:01.874835Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037897 on unit StoreSchemeTx
2025-12-09T04:01:01.874837Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1949: Complete execution for [0:281474976715658] at 72075186224037897 on unit FinishPropose
2025-12-09T04:01:01.874841Z node 7 :TX_DATASHARD TRACE: finish_propose_unit.cpp:167: Propose transaction complete txid 281474976715658 at tablet 72075186224037897 send to client, exec latency: 0 ms, propose latency: 4 ms, status: PREPARED
2025-12-09T04:01:01.874847Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:466: 72075186224037897 not sending time cast registration request in state WaitScheme
2025-12-09T04:01:01.879258Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827078246:2952], Recipient [7:7581703308827077896:2321]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.879265Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.879271Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037896, clientId# [7:7581703308827078245:2951], serverId# [7:7581703308827078246:2952], sessionId# [0:0:0]
2025-12-09T04:01:01.879278Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827078247:2953], Recipient [7:7581703308827077900:2324]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.879280Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.879284Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037894, clientId# [7:7581703308827078244:2950], serverId# [7:7581703308827078247:2953], sessionId# [0:0:0]
2025-12-09T04:01:01.879289Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269287424, Sender [7:7581703308827077407:2380], Recipient [7:7581703308827077900:2324]: {TEvPlanStep step# 1765252861925 MediatorId# 72057594046382081 TabletID 72075186224037894}
2025-12-09T04:01:01.879291Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3162: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-12-09T04:01:01.879304Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827078249:2955], Recipient [7:7581703308827077881:2320]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.879306Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.879310Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037891, clientId# [7:7581703308827078237:2943], serverId# [7:7581703308827078249:2955], sessionId# [0:0:0]
2025-12-09T04:01:01.879315Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269287424, Sender [7:7581703308827077408:2381], Recipient [7:7581703308827077881:2320]: {TEvPlanStep step# 1765252861925 MediatorId# 72057594046382081 TabletID 72075186224037891}
2025-12-09T04:01:01.879317Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3162: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-12-09T04:01:01.879323Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1806: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit WaitForPlan
2025-12-09T04:01:01.879330Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1821: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879333Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit WaitForPlan
2025-12-09T04:01:01.879336Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit PlanQueue
2025-12-09T04:01:01.879338Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1806: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit WaitForPlan
2025-12-09T04:01:01.879340Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1821: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879343Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit WaitForPlan
2025-12-09T04:01:01.879345Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit PlanQueue
2025-12-09T04:01:01.879385Z node 7 :TX_DATASHARD DEBUG: datashard__plan_step.cpp:69: Planned transaction txId 281474976715658 at step 1765252861925 at tablet 72075186224037891 { Transactions { TxId: 281474976715658 AckTo { RawX1: 0 RawX2: 0 } } Step: 1765252861925 MediatorID: 72057594046382081 TabletID: 72075186224037891 }
2025-12-09T04:01:01.879389Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037891
2025-12-09T04:01:01.879396Z node 7 :TX_DATASHARD DEBUG: datashard__plan_step.cpp:69: Planned transaction txId 281474976715658 at step 1765252861925 at tablet 72075186224037894 { Transactions { TxId: 281474976715658 AckTo { RawX1: 0 RawX2: 0 } } Step: 1765252861925 MediatorID: 72057594046382081 TabletID: 72075186224037894 }
2025-12-09T04:01:01.879398Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037894
2025-12-09T04:01:01.879413Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077881:2320], Recipient [7:7581703308827077881:2320]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.879415Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.879418Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077900:2324], Recipient [7:7581703308827077900:2324]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.879420Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037891
2025-12-09T04:01:01.879420Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.879423Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037894
2025-12-09T04:01:01.879425Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037891 active 0 active planned 0 immediate 0 planned 1
2025-12-09T04:01:01.879429Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037891
2025-12-09T04:01:01.879436Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:333: Found ready operation [1765252861925:281474976715658] in PlanQueue unit at 72075186224037891
2025-12-09T04:01:01.879436Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037894 active 0 active planned 0 immediate 0 planned 1
2025-12-09T04:01:01.879438Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037894
2025-12-09T04:01:01.879439Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit PlanQueue
2025-12-09T04:01:01.879441Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:333: Found ready operation [1765252861925:281474976715658] in PlanQueue unit at 72075186224037894
2025-12-09T04:01:01.879444Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit PlanQueue
2025-12-09T04:01:01.879444Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879447Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit PlanQueue
2025-12-09T04:01:01.879448Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879449Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit LoadTxDetails
2025-12-09T04:01:01.879449Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit PlanQueue
2025-12-09T04:01:01.879451Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit LoadTxDetails
2025-12-09T04:01:01.879452Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit LoadTxDetails
2025-12-09T04:01:01.879453Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit LoadTxDetails
2025-12-09T04:01:01.879508Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:634: LoadTxDetails at 72075186224037894 loaded tx from db 1765252861925:281474976715658 keys extracted: 0
2025-12-09T04:01:01.879508Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:634: LoadTxDetails at 72075186224037891 loaded tx from db 1765252861925:281474976715658 keys extracted: 0
2025-12-09T04:01:01.879510Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879511Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit LoadTxDetails
2025-12-09T04:01:01.879512Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879514Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit LoadTxDetails
2025-12-09T04:01:01.879514Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit ProtectSchemeEchoes
2025-12-09T04:01:01.879515Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit ProtectSchemeEchoes
2025-12-09T04:01:01.879516Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit ProtectSchemeEchoes
2025-12-09T04:01:01.879517Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit ProtectSchemeEchoes
2025-12-09T04:01:01.879524Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is ExecutedNoMoreRestarts
2025-12-09T04:01:01.879524Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is ExecutedNoMoreRestarts
2025-12-09T04:01:01.879526Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit ProtectSchemeEchoes
2025-12-09T04:01:01.879527Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit ProtectSchemeEchoes
2025-12-09T04:01:01.879528Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit BuildAndWaitDependencies
2025-12-09T04:01:01.879531Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit BuildAndWaitDependencies
2025-12-09T04:01:01.879535Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit BuildAndWaitDependencies
2025-12-09T04:01:01.879538Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit BuildAndWaitDependencies
2025-12-09T04:01:01.879541Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:455: Operation [1765252861925:281474976715658] is the new logically complete end at 72075186224037894
2025-12-09T04:01:01.879542Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:455: Operation [1765252861925:281474976715658] is the new logically complete end at 72075186224037891
2025-12-09T04:01:01.879543Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:461: Operation [1765252861925:281474976715658] is the new logically incomplete end at 72075186224037894
2025-12-09T04:01:01.879544Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:461: Operation [1765252861925:281474976715658] is the new logically incomplete end at 72075186224037891
2025-12-09T04:01:01.879545Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:483: Activated operation [1765252861925:281474976715658] at 72075186224037891
2025-12-09T04:01:01.879545Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:483: Activated operation [1765252861925:281474976715658] at 72075186224037894
2025-12-09T04:01:01.879549Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879550Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879551Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit BuildAndWaitDependencies
2025-12-09T04:01:01.879552Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit BuildAndWaitDependencies
2025-12-09T04:01:01.879554Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit MakeSnapshot
2025-12-09T04:01:01.879554Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit MakeSnapshot
2025-12-09T04:01:01.879556Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit MakeSnapshot
2025-12-09T04:01:01.879557Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit MakeSnapshot
2025-12-09T04:01:01.879558Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879559Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879560Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit MakeSnapshot
2025-12-09T04:01:01.879561Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit MakeSnapshot
2025-12-09T04:01:01.879562Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit BuildSchemeTxOutRS
2025-12-09T04:01:01.879563Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit BuildSchemeTxOutRS
2025-12-09T04:01:01.879565Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit BuildSchemeTxOutRS
2025-12-09T04:01:01.879565Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit BuildSchemeTxOutRS
2025-12-09T04:01:01.879567Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879569Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879569Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit BuildSchemeTxOutRS
2025-12-09T04:01:01.879571Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit BuildSchemeTxOutRS
2025-12-09T04:01:01.879571Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit StoreAndSendOutRS
2025-12-09T04:01:01.879572Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit StoreAndSendOutRS
2025-12-09T04:01:01.879575Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit StoreAndSendOutRS
2025-12-09T04:01:01.879578Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879578Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit StoreAndSendOutRS
2025-12-09T04:01:01.879580Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit StoreAndSendOutRS
2025-12-09T04:01:01.879581Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879581Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit PrepareSchemeTxInRS
2025-12-09T04:01:01.879583Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit StoreAndSendOutRS
2025-12-09T04:01:01.879584Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit PrepareSchemeTxInRS
2025-12-09T04:01:01.879584Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit PrepareSchemeTxInRS
2025-12-09T04:01:01.879586Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879586Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit PrepareSchemeTxInRS
2025-12-09T04:01:01.879588Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879588Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit PrepareSchemeTxInRS
2025-12-09T04:01:01.879590Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit PrepareSchemeTxInRS
2025-12-09T04:01:01.879590Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit LoadAndWaitInRS
2025-12-09T04:01:01.879591Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit LoadAndWaitInRS
2025-12-09T04:01:01.879592Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit LoadAndWaitInRS
2025-12-09T04:01:01.879593Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit LoadAndWaitInRS
2025-12-09T04:01:01.879596Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1859: Operation [1765252861925:281474976715658] at 72075186224037894 cannot execute on unit LoadAndWaitInRS because no more restarts are allowed
2025-12-09T04:01:01.879596Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1859: Operation [1765252861925:281474976715658] at 72075186224037891 cannot execute on unit LoadAndWaitInRS because no more restarts are allowed
2025-12-09T04:01:01.879598Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037894 (dry run) active 1 active planned 1 immediate 0 planned 1
2025-12-09T04:01:01.879598Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037891 (dry run) active 1 active planned 1 immediate 0 planned 1
2025-12-09T04:01:01.879599Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037894
2025-12-09T04:01:01.879599Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037891
2025-12-09T04:01:01.879602Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:52: TPlanQueueUnit at 72075186224037891 out-of-order limits exceeded
2025-12-09T04:01:01.879603Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:52: TPlanQueueUnit at 72075186224037894 out-of-order limits exceeded
2025-12-09T04:01:01.879603Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:341: Unit PlanQueue has no ready operations at 72075186224037891
2025-12-09T04:01:01.879604Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:341: Unit PlanQueue has no ready operations at 72075186224037894
2025-12-09T04:01:01.879617Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037891
2025-12-09T04:01:01.879618Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037894
2025-12-09T04:01:01.879619Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit LoadAndWaitInRS
2025-12-09T04:01:01.879621Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879623Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit LoadAndWaitInRS
2025-12-09T04:01:01.879625Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit Backup
2025-12-09T04:01:01.879625Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit LoadAndWaitInRS
2025-12-09T04:01:01.879627Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit Backup
2025-12-09T04:01:01.879628Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879629Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit LoadAndWaitInRS
2025-12-09T04:01:01.879630Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879631Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit Backup
2025-12-09T04:01:01.879632Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit Backup
2025-12-09T04:01:01.879633Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit Restore
2025-12-09T04:01:01.879635Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit Backup
2025-12-09T04:01:01.879635Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit Restore
2025-12-09T04:01:01.879637Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879638Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit Backup
2025-12-09T04:01:01.879639Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879640Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit Restore
2025-12-09T04:01:01.879640Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit Restore
2025-12-09T04:01:01.879642Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit Restore
2025-12-09T04:01:01.879642Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit CreateTable
2025-12-09T04:01:01.879643Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879644Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit CreateTable
2025-12-09T04:01:01.879645Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit Restore
2025-12-09T04:01:01.879646Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit CreateTable
2025-12-09T04:01:01.879648Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit CreateTable
2025-12-09T04:01:01.879650Z node 7 :TX_DATASHARD INFO: create_table_unit.cpp:69: Trying to CREATE TABLE at 72075186224037894 tableId# [OwnerId: 72057594046644480, LocalPathId: 2] schema version# 1
2025-12-09T04:01:01.879650Z node 7 :TX_DATASHARD INFO: create_table_unit.cpp:69: Trying to CREATE TABLE at 72075186224037891 tableId# [OwnerId: 72057594046644480, LocalPathId: 2] schema version# 1
2025-12-09T04:01:01.879747Z node 7 :TX_DATASHARD INFO: datashard.cpp:474: Send registration request to time cast Ready tabletId 72075186224037891 mediators count is 1 coordinators count is 1 buckets per mediator 2
2025-12-09T04:01:01.879747Z node 7 :TX_DATASHARD INFO: datashard.cpp:474: Send registration request to time cast Ready tabletId 72075186224037894 mediators count is 1 coordinators count is 1 buckets per mediator 2
2025-12-09T04:01:01.879752Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is DelayCompleteNoMoreRestarts
2025-12-09T04:01:01.879754Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit CreateTable
2025-12-09T04:01:01.879756Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit ReceiveSnapshot
2025-12-09T04:01:01.879758Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit ReceiveSnapshot
2025-12-09T04:01:01.879761Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879764Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is DelayCompleteNoMoreRestarts
2025-12-09T04:01:01.879765Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit ReceiveSnapshot
2025-12-09T04:01:01.879766Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit CreateTable
2025-12-09T04:01:01.879767Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit ReceiveSnapshot
2025-12-09T04:01:01.879767Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit ReceiveSnapshotCleanup
2025-12-09T04:01:01.879769Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit ReceiveSnapshot
2025-12-09T04:01:01.879769Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit ReceiveSnapshotCleanup
2025-12-09T04:01:01.879771Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879773Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879774Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit ReceiveSnapshotCleanup
2025-12-09T04:01:01.879774Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit ReceiveSnapshot
2025-12-09T04:01:01.879776Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit ReceiveSnapshotCleanup
2025-12-09T04:01:01.879776Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit AlterMoveShadow
2025-12-09T04:01:01.879778Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit ReceiveSnapshotCleanup
2025-12-09T04:01:01.879778Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit AlterMoveShadow
2025-12-09T04:01:01.879780Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879781Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879782Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit ReceiveSnapshotCleanup
2025-12-09T04:01:01.879783Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit AlterMoveShadow
2025-12-09T04:01:01.879783Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit AlterMoveShadow
2025-12-09T04:01:01.879785Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit AlterTable
2025-12-09T04:01:01.879785Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit AlterMoveShadow
2025-12-09T04:01:01.879787Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879789Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit AlterMoveShadow
2025-12-09T04:01:01.879790Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit AlterTable
2025-12-09T04:01:01.879791Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit AlterTable
2025-12-09T04:01:01.879794Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879796Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit AlterTable
2025-12-09T04:01:01.879797Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit AlterTable
2025-12-09T04:01:01.879798Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879798Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit DropTable
2025-12-09T04:01:01.879800Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit DropTable
2025-12-09T04:01:01.879800Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit AlterTable
2025-12-09T04:01:01.879802Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit DropTable
2025-12-09T04:01:01.879803Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879804Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit DropTable
2025-12-09T04:01:01.879805Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit DropTable
2025-12-09T04:01:01.879806Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879806Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit CreatePersistentSnapshot
2025-12-09T04:01:01.879807Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit DropTable
2025-12-09T04:01:01.879808Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit CreatePersistentSnapshot
2025-12-09T04:01:01.879809Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit CreatePersistentSnapshot
2025-12-09T04:01:01.879810Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879812Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit CreatePersistentSnapshot
2025-12-09T04:01:01.879812Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit CreatePersistentSnapshot
2025-12-09T04:01:01.879813Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879814Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit DropPersistentSnapshot
2025-12-09T04:01:01.879815Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit CreatePersistentSnapshot
2025-12-09T04:01:01.879817Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit DropPersistentSnapshot
2025-12-09T04:01:01.879817Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit DropPersistentSnapshot
2025-12-09T04:01:01.879819Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879819Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit DropPersistentSnapshot
2025-12-09T04:01:01.879821Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit DropPersistentSnapshot
2025-12-09T04:01:01.879821Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879823Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit DropPersistentSnapshot
2025-12-09T04:01:01.879823Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit InitiateBuildIndex
2025-12-09T04:01:01.879824Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit InitiateBuildIndex
2025-12-09T04:01:01.879825Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit InitiateBuildIndex
2025-12-09T04:01:01.879826Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit InitiateBuildIndex
2025-12-09T04:01:01.879828Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879829Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit InitiateBuildIndex
2025-12-09T04:01:01.879831Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit FinalizeBuildIndex
2025-12-09T04:01:01.879833Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit FinalizeBuildIndex
2025-12-09T04:01:01.879835Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879836Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879837Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit FinalizeBuildIndex
2025-12-09T04:01:01.879838Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit InitiateBuildIndex
2025-12-09T04:01:01.879839Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit DropIndexNotice
2025-12-09T04:01:01.879840Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit FinalizeBuildIndex
2025-12-09T04:01:01.879841Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit DropIndexNotice
2025-12-09T04:01:01.879842Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit FinalizeBuildIndex
2025-12-09T04:01:01.879844Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879844Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879846Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit DropIndexNotice
2025-12-09T04:01:01.879847Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit FinalizeBuildIndex
2025-12-09T04:01:01.879847Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit MoveTable
2025-12-09T04:01:01.879848Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit DropIndexNotice
2025-12-09T04:01:01.879850Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit MoveTable
2025-12-09T04:01:01.879851Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit DropIndexNotice
2025-12-09T04:01:01.879852Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879853Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879854Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit MoveTable
2025-12-09T04:01:01.879855Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit DropIndexNotice
2025-12-09T04:01:01.879856Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit MoveTable
2025-12-09T04:01:01.879857Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit MoveIndex
2025-12-09T04:01:01.879858Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit MoveTable
2025-12-09T04:01:01.879859Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879861Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit MoveTable
2025-12-09T04:01:01.879862Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit MoveIndex
2025-12-09T04:01:01.879863Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit MoveIndex
2025-12-09T04:01:01.879865Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit MoveIndex
2025-12-09T04:01:01.879865Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879866Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879867Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit MoveIndex
2025-12-09T04:01:01.879868Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit MoveIndex
2025-12-09T04:01:01.879869Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit CreateCdcStream
2025-12-09T04:01:01.879869Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit CreateCdcStream
2025-12-09T04:01:01.879871Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit CreateCdcStream
2025-12-09T04:01:01.879871Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit CreateCdcStream
2025-12-09T04:01:01.879873Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879874Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879875Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit CreateCdcStream
2025-12-09T04:01:01.879875Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit CreateCdcStream
2025-12-09T04:01:01.879877Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit AlterCdcStream
2025-12-09T04:01:01.879877Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit AlterCdcStream
2025-12-09T04:01:01.879879Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit AlterCdcStream
2025-12-09T04:01:01.879880Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit AlterCdcStream
2025-12-09T04:01:01.879882Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879883Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879885Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit AlterCdcStream
2025-12-09T04:01:01.879885Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit AlterCdcStream
2025-12-09T04:01:01.879887Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit DropCdcStream
2025-12-09T04:01:01.879887Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit DropCdcStream
2025-12-09T04:01:01.879889Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit DropCdcStream
2025-12-09T04:01:01.879889Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit DropCdcStream
2025-12-09T04:01:01.879891Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879891Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879893Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit DropCdcStream
2025-12-09T04:01:01.879893Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit DropCdcStream
2025-12-09T04:01:01.879895Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit RotateCdcStream
2025-12-09T04:01:01.879895Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit RotateCdcStream
2025-12-09T04:01:01.879897Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit RotateCdcStream
2025-12-09T04:01:01.879897Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit RotateCdcStream
2025-12-09T04:01:01.879900Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879903Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit RotateCdcStream
2025-12-09T04:01:01.879904Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879905Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit CreateIncrementalRestoreSrc
2025-12-09T04:01:01.879907Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit RotateCdcStream
2025-12-09T04:01:01.879908Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit CreateIncrementalRestoreSrc
2025-12-09T04:01:01.879908Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit CreateIncrementalRestoreSrc
2025-12-09T04:01:01.879910Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879911Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit CreateIncrementalRestoreSrc
2025-12-09T04:01:01.879912Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit CreateIncrementalRestoreSrc
2025-12-09T04:01:01.879913Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879914Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit CompleteOperation
2025-12-09T04:01:01.879916Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit CreateIncrementalRestoreSrc
2025-12-09T04:01:01.879917Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit CompleteOperation
2025-12-09T04:01:01.879917Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit CompleteOperation
2025-12-09T04:01:01.879919Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit CompleteOperation
2025-12-09T04:01:01.879959Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is DelayComplete
2025-12-09T04:01:01.879959Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is DelayComplete
2025-12-09T04:01:01.879961Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit CompleteOperation
2025-12-09T04:01:01.879961Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit CompleteOperation
2025-12-09T04:01:01.879963Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037894 to execution unit CompletedOperations
2025-12-09T04:01:01.879963Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037891 to execution unit CompletedOperations
2025-12-09T04:01:01.879965Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037894 on unit CompletedOperations
2025-12-09T04:01:01.879965Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037891 on unit CompletedOperations
2025-12-09T04:01:01.879968Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037891 is Executed
2025-12-09T04:01:01.879968Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037894 is Executed
2025-12-09T04:01:01.879970Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037891 executing on unit CompletedOperations
2025-12-09T04:01:01.879970Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037894 executing on unit CompletedOperations
2025-12-09T04:01:01.879972Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1938: Execution plan for [1765252861925:281474976715658] at 72075186224037894 has finished
2025-12-09T04:01:01.879972Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1938: Execution plan for [1765252861925:281474976715658] at 72075186224037891 has finished
2025-12-09T04:01:01.879975Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037894 (dry run) active 0 active planned 0 immediate 0 planned 0
2025-12-09T04:01:01.879977Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037894
2025-12-09T04:01:01.879978Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037891 (dry run) active 0 active planned 0 immediate 0 planned 0
2025-12-09T04:01:01.879978Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037894 has no attached operations
2025-12-09T04:01:01.879979Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037891
2025-12-09T04:01:01.879979Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:341: Unit PlanQueue has no ready operations at 72075186224037894
2025-12-09T04:01:01.879980Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037891 has no attached operations
2025-12-09T04:01:01.879981Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:341: Unit PlanQueue has no ready operations at 72075186224037891
2025-12-09T04:01:01.880263Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 270270976, Sender [7:7581703308827076730:2075], Recipient [7:7581703308827077881:2320]: {TEvRegisterTabletResult TabletId# 72075186224037891 Entry# 1765252861924}
2025-12-09T04:01:01.880263Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 270270976, Sender [7:7581703308827076730:2075], Recipient [7:7581703308827077900:2324]: {TEvRegisterTabletResult TabletId# 72075186224037894 Entry# 1765252861924}
2025-12-09T04:01:01.880266Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3182: StateWork, processing event TEvMediatorTimecast::TEvRegisterTabletResult
2025-12-09T04:01:01.880266Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3182: StateWork, processing event TEvMediatorTimecast::TEvRegisterTabletResult
2025-12-09T04:01:01.880269Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3752: Got TEvMediatorTimecast::TEvRegisterTabletResult at 72075186224037894 time 1765252861924
2025-12-09T04:01:01.880269Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3752: Got TEvMediatorTimecast::TEvRegisterTabletResult at 72075186224037891 time 1765252861924
2025-12-09T04:01:01.880271Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037891
2025-12-09T04:01:01.880271Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037894
2025-12-09T04:01:01.880284Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827078250:2956], Recipient [7:7581703308827077903:2327]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.880284Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827078255:2961], Recipient [7:7581703308827077897:2322]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.880286Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.880286Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.880290Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037890, clientId# [7:7581703308827078242:2948], serverId# [7:7581703308827078255:2961], sessionId# [0:0:0]
2025-12-09T04:01:01.880290Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037893, clientId# [7:7581703308827078238:2944], serverId# [7:7581703308827078250:2956], sessionId# [0:0:0]
2025-12-09T04:01:01.880294Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269287424, Sender [7:7581703308827077408:2381], Recipient [7:7581703308827077903:2327]: {TEvPlanStep step# 1765252861925 MediatorId# 72057594046382081 TabletID 72075186224037893}
2025-12-09T04:01:01.880294Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269287424, Sender [7:7581703308827077407:2380], Recipient [7:7581703308827077897:2322]: {TEvPlanStep step# 1765252861925 MediatorId# 72057594046382081 TabletID 72075186224037890}
2025-12-09T04:01:01.880296Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3162: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-12-09T04:01:01.880296Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3162: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-12-09T04:01:01.880311Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1806: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit WaitForPlan
2025-12-09T04:01:01.880310Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1806: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit WaitForPlan
2025-12-09T04:01:01.880313Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1821: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880313Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1821: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880315Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit WaitForPlan
2025-12-09T04:01:01.880315Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit WaitForPlan
2025-12-09T04:01:01.880317Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit PlanQueue
2025-12-09T04:01:01.880324Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit PlanQueue
2025-12-09T04:01:01.880343Z node 7 :TX_DATASHARD DEBUG: datashard__plan_step.cpp:69: Planned transaction txId 281474976715658 at step 1765252861925 at tablet 72075186224037893 { Transactions { TxId: 281474976715658 AckTo { RawX1: 0 RawX2: 0 } } Step: 1765252861925 MediatorID: 72057594046382081 TabletID: 72075186224037893 }
2025-12-09T04:01:01.880343Z node 7 :TX_DATASHARD DEBUG: datashard__plan_step.cpp:69: Planned transaction txId 281474976715658 at step 1765252861925 at tablet 72075186224037890 { Transactions { TxId: 281474976715658 AckTo { RawX1: 0 RawX2: 0 } } Step: 1765252861925 MediatorID: 72057594046382081 TabletID: 72075186224037890 }
2025-12-09T04:01:01.880344Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037893
2025-12-09T04:01:01.880344Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037890
2025-12-09T04:01:01.880361Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077903:2327], Recipient [7:7581703308827077903:2327]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.880361Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077897:2322], Recipient [7:7581703308827077897:2322]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.880363Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.880363Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.880366Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037893
2025-12-09T04:01:01.880366Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037890
2025-12-09T04:01:01.880368Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037890 active 0 active planned 0 immediate 0 planned 1
2025-12-09T04:01:01.880369Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037893 active 0 active planned 0 immediate 0 planned 1
2025-12-09T04:01:01.880370Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037890
2025-12-09T04:01:01.880370Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037893
2025-12-09T04:01:01.880373Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:333: Found ready operation [1765252861925:281474976715658] in PlanQueue unit at 72075186224037890
2025-12-09T04:01:01.880374Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:333: Found ready operation [1765252861925:281474976715658] in PlanQueue unit at 72075186224037893
2025-12-09T04:01:01.880375Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit PlanQueue
2025-12-09T04:01:01.880376Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit PlanQueue
2025-12-09T04:01:01.880378Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880379Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880380Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit PlanQueue
2025-12-09T04:01:01.880380Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit PlanQueue
2025-12-09T04:01:01.880382Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit LoadTxDetails
2025-12-09T04:01:01.880384Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit LoadTxDetails
2025-12-09T04:01:01.880388Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit LoadTxDetails
2025-12-09T04:01:01.880390Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit LoadTxDetails
2025-12-09T04:01:01.880417Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:634: LoadTxDetails at 72075186224037890 loaded tx from db 1765252861925:281474976715658 keys extracted: 0
2025-12-09T04:01:01.880418Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:634: LoadTxDetails at 72075186224037893 loaded tx from db 1765252861925:281474976715658 keys extracted: 0
2025-12-09T04:01:01.880419Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880419Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880421Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit LoadTxDetails
2025-12-09T04:01:01.880421Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit LoadTxDetails
2025-12-09T04:01:01.880423Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit ProtectSchemeEchoes
2025-12-09T04:01:01.880422Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit ProtectSchemeEchoes
2025-12-09T04:01:01.880425Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit ProtectSchemeEchoes
2025-12-09T04:01:01.880425Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit ProtectSchemeEchoes
2025-12-09T04:01:01.880430Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is ExecutedNoMoreRestarts
2025-12-09T04:01:01.880430Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is ExecutedNoMoreRestarts
2025-12-09T04:01:01.880432Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit ProtectSchemeEchoes
2025-12-09T04:01:01.880432Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit ProtectSchemeEchoes
2025-12-09T04:01:01.880434Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit BuildAndWaitDependencies
2025-12-09T04:01:01.880434Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit BuildAndWaitDependencies
2025-12-09T04:01:01.880436Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit BuildAndWaitDependencies
2025-12-09T04:01:01.880436Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit BuildAndWaitDependencies
2025-12-09T04:01:01.880441Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:455: Operation [1765252861925:281474976715658] is the new logically complete end at 72075186224037893
2025-12-09T04:01:01.880441Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:455: Operation [1765252861925:281474976715658] is the new logically complete end at 72075186224037890
2025-12-09T04:01:01.880443Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:461: Operation [1765252861925:281474976715658] is the new logically incomplete end at 72075186224037893
2025-12-09T04:01:01.880443Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:461: Operation [1765252861925:281474976715658] is the new logically incomplete end at 72075186224037890
2025-12-09T04:01:01.880446Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:483: Activated operation [1765252861925:281474976715658] at 72075186224037890
2025-12-09T04:01:01.880447Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:483: Activated operation [1765252861925:281474976715658] at 72075186224037893
2025-12-09T04:01:01.880449Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880450Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880452Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit BuildAndWaitDependencies
2025-12-09T04:01:01.880452Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit BuildAndWaitDependencies
2025-12-09T04:01:01.880454Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit MakeSnapshot
2025-12-09T04:01:01.880456Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit MakeSnapshot
2025-12-09T04:01:01.880458Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880459Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit MakeSnapshot
2025-12-09T04:01:01.880461Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit MakeSnapshot
2025-12-09T04:01:01.880461Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit BuildSchemeTxOutRS
2025-12-09T04:01:01.880463Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit MakeSnapshot
2025-12-09T04:01:01.880463Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit BuildSchemeTxOutRS
2025-12-09T04:01:01.880465Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880465Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880466Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit MakeSnapshot
2025-12-09T04:01:01.880467Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit BuildSchemeTxOutRS
2025-12-09T04:01:01.880468Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit BuildSchemeTxOutRS
2025-12-09T04:01:01.880468Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit StoreAndSendOutRS
2025-12-09T04:01:01.880470Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit BuildSchemeTxOutRS
2025-12-09T04:01:01.880470Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit StoreAndSendOutRS
2025-12-09T04:01:01.880472Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880472Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880474Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit BuildSchemeTxOutRS
2025-12-09T04:01:01.880474Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit StoreAndSendOutRS
2025-12-09T04:01:01.880475Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit StoreAndSendOutRS
2025-12-09T04:01:01.880476Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit PrepareSchemeTxInRS
2025-12-09T04:01:01.880477Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit StoreAndSendOutRS
2025-12-09T04:01:01.880478Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit PrepareSchemeTxInRS
2025-12-09T04:01:01.880479Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880479Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880481Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit StoreAndSendOutRS
2025-12-09T04:01:01.880484Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit PrepareSchemeTxInRS
2025-12-09T04:01:01.880484Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit PrepareSchemeTxInRS
2025-12-09T04:01:01.880486Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit LoadAndWaitInRS
2025-12-09T04:01:01.880486Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit PrepareSchemeTxInRS
2025-12-09T04:01:01.880488Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880489Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit LoadAndWaitInRS
2025-12-09T04:01:01.880490Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit PrepareSchemeTxInRS
2025-12-09T04:01:01.880491Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit LoadAndWaitInRS
2025-12-09T04:01:01.880492Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1859: Operation [1765252861925:281474976715658] at 72075186224037893 cannot execute on unit LoadAndWaitInRS because no more restarts are allowed
2025-12-09T04:01:01.880493Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit LoadAndWaitInRS
2025-12-09T04:01:01.880493Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037893 (dry run) active 1 active planned 1 immediate 0 planned 1
2025-12-09T04:01:01.880495Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1859: Operation [1765252861925:281474976715658] at 72075186224037890 cannot execute on unit LoadAndWaitInRS because no more restarts are allowed
2025-12-09T04:01:01.880495Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037893
2025-12-09T04:01:01.880496Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037890 (dry run) active 1 active planned 1 immediate 0 planned 1
2025-12-09T04:01:01.880497Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037890
2025-12-09T04:01:01.880497Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:52: TPlanQueueUnit at 72075186224037893 out-of-order limits exceeded
2025-12-09T04:01:01.880498Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:52: TPlanQueueUnit at 72075186224037890 out-of-order limits exceeded
2025-12-09T04:01:01.880499Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:341: Unit PlanQueue has no ready operations at 72075186224037893
2025-12-09T04:01:01.880499Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:341: Unit PlanQueue has no ready operations at 72075186224037890
2025-12-09T04:01:01.880509Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037890
2025-12-09T04:01:01.880509Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037893
2025-12-09T04:01:01.880511Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit LoadAndWaitInRS
2025-12-09T04:01:01.880511Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit LoadAndWaitInRS
2025-12-09T04:01:01.880512Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880513Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880514Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit LoadAndWaitInRS
2025-12-09T04:01:01.880514Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit LoadAndWaitInRS
2025-12-09T04:01:01.880516Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit Backup
2025-12-09T04:01:01.880516Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit Backup
2025-12-09T04:01:01.880518Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit Backup
2025-12-09T04:01:01.880518Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit Backup
2025-12-09T04:01:01.880520Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880520Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880522Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit Backup
2025-12-09T04:01:01.880522Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit Backup
2025-12-09T04:01:01.880524Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit Restore
2025-12-09T04:01:01.880524Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit Restore
2025-12-09T04:01:01.880525Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit Restore
2025-12-09T04:01:01.880527Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880529Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit Restore
2025-12-09T04:01:01.880530Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit Restore
2025-12-09T04:01:01.880530Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit CreateTable
2025-12-09T04:01:01.880532Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880532Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit CreateTable
2025-12-09T04:01:01.880534Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit Restore
2025-12-09T04:01:01.880535Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit CreateTable
2025-12-09T04:01:01.880536Z node 7 :TX_DATASHARD INFO: create_table_unit.cpp:69: Trying to CREATE TABLE at 72075186224037893 tableId# [OwnerId: 72057594046644480, LocalPathId: 2] schema version# 1
2025-12-09T04:01:01.880537Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit CreateTable
2025-12-09T04:01:01.880539Z node 7 :TX_DATASHARD INFO: create_table_unit.cpp:69: Trying to CREATE TABLE at 72075186224037890 tableId# [OwnerId: 72057594046644480, LocalPathId: 2] schema version# 1
2025-12-09T04:01:01.880590Z node 7 :TX_DATASHARD INFO: datashard.cpp:474: Send registration request to time cast Ready tabletId 72075186224037893 mediators count is 1 coordinators count is 1 buckets per mediator 2
2025-12-09T04:01:01.880591Z node 7 :TX_DATASHARD INFO: datashard.cpp:474: Send registration request to time cast Ready tabletId 72075186224037890 mediators count is 1 coordinators count is 1 buckets per mediator 2
2025-12-09T04:01:01.880595Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is DelayCompleteNoMoreRestarts
2025-12-09T04:01:01.880597Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit CreateTable
2025-12-09T04:01:01.880598Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit ReceiveSnapshot
2025-12-09T04:01:01.880600Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit ReceiveSnapshot
2025-12-09T04:01:01.880602Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880603Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is DelayCompleteNoMoreRestarts
2025-12-09T04:01:01.880604Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit ReceiveSnapshot
2025-12-09T04:01:01.880605Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit ReceiveSnapshotCleanup
2025-12-09T04:01:01.880605Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit CreateTable
2025-12-09T04:01:01.880607Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit ReceiveSnapshot
2025-12-09T04:01:01.880607Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit ReceiveSnapshotCleanup
2025-12-09T04:01:01.880609Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit ReceiveSnapshot
2025-12-09T04:01:01.880610Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880611Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880612Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit ReceiveSnapshotCleanup
2025-12-09T04:01:01.880614Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit AlterMoveShadow
2025-12-09T04:01:01.880616Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit AlterMoveShadow
2025-12-09T04:01:01.880618Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880619Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit ReceiveSnapshot
2025-12-09T04:01:01.880619Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit AlterMoveShadow
2025-12-09T04:01:01.880621Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit AlterTable
2025-12-09T04:01:01.880621Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit ReceiveSnapshotCleanup
2025-12-09T04:01:01.880623Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit AlterTable
2025-12-09T04:01:01.880623Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit ReceiveSnapshotCleanup
2025-12-09T04:01:01.880625Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880625Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880626Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit AlterTable
2025-12-09T04:01:01.880627Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit ReceiveSnapshotCleanup
2025-12-09T04:01:01.880628Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit DropTable
2025-12-09T04:01:01.880629Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit AlterMoveShadow
2025-12-09T04:01:01.880630Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit DropTable
2025-12-09T04:01:01.880630Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit AlterMoveShadow
2025-12-09T04:01:01.880632Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880632Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880633Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit DropTable
2025-12-09T04:01:01.880634Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit AlterMoveShadow
2025-12-09T04:01:01.880635Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit CreatePersistentSnapshot
2025-12-09T04:01:01.880636Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit AlterTable
2025-12-09T04:01:01.880637Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit AlterTable
2025-12-09T04:01:01.880641Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit CreatePersistentSnapshot
2025-12-09T04:01:01.880641Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880643Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880643Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit AlterTable
2025-12-09T04:01:01.880645Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit DropTable
2025-12-09T04:01:01.880645Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit CreatePersistentSnapshot
2025-12-09T04:01:01.880647Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit DropTable
2025-12-09T04:01:01.880647Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit DropPersistentSnapshot
2025-12-09T04:01:01.880648Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880650Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit DropPersistentSnapshot
2025-12-09T04:01:01.880650Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit DropTable
2025-12-09T04:01:01.880651Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880652Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit CreatePersistentSnapshot
2025-12-09T04:01:01.880653Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit DropPersistentSnapshot
2025-12-09T04:01:01.880654Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit CreatePersistentSnapshot
2025-12-09T04:01:01.880655Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880657Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit CreatePersistentSnapshot
2025-12-09T04:01:01.880658Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit InitiateBuildIndex
2025-12-09T04:01:01.880658Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit DropPersistentSnapshot
2025-12-09T04:01:01.880660Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit InitiateBuildIndex
2025-12-09T04:01:01.880660Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit DropPersistentSnapshot
2025-12-09T04:01:01.880661Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880662Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880663Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit InitiateBuildIndex
2025-12-09T04:01:01.880664Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit DropPersistentSnapshot
2025-12-09T04:01:01.880665Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit FinalizeBuildIndex
2025-12-09T04:01:01.880665Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit InitiateBuildIndex
2025-12-09T04:01:01.880666Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit FinalizeBuildIndex
2025-12-09T04:01:01.880668Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880668Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit InitiateBuildIndex
2025-12-09T04:01:01.880670Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit FinalizeBuildIndex
2025-12-09T04:01:01.880670Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880671Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit DropIndexNotice
2025-12-09T04:01:01.880672Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit InitiateBuildIndex
2025-12-09T04:01:01.880673Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit FinalizeBuildIndex
2025-12-09T04:01:01.880673Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit DropIndexNotice
2025-12-09T04:01:01.880675Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880676Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit FinalizeBuildIndex
2025-12-09T04:01:01.880677Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit DropIndexNotice
2025-12-09T04:01:01.880678Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880679Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit MoveTable
2025-12-09T04:01:01.880679Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit FinalizeBuildIndex
2025-12-09T04:01:01.880681Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit MoveTable
2025-12-09T04:01:01.880683Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880685Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit DropIndexNotice
2025-12-09T04:01:01.880685Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit MoveTable
2025-12-09T04:01:01.880687Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit MoveIndex
2025-12-09T04:01:01.880687Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit DropIndexNotice
2025-12-09T04:01:01.880689Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit MoveIndex
2025-12-09T04:01:01.880689Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880690Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880691Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit DropIndexNotice
2025-12-09T04:01:01.880693Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit MoveTable
2025-12-09T04:01:01.880693Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit MoveIndex
2025-12-09T04:01:01.880695Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit MoveTable
2025-12-09T04:01:01.880695Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit CreateCdcStream
2025-12-09T04:01:01.880696Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit CreateCdcStream
2025-12-09T04:01:01.880696Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880698Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880698Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit MoveTable
2025-12-09T04:01:01.880700Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit MoveIndex
2025-12-09T04:01:01.880700Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit CreateCdcStream
2025-12-09T04:01:01.880702Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit MoveIndex
2025-12-09T04:01:01.880702Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit AlterCdcStream
2025-12-09T04:01:01.880704Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880706Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit MoveIndex
2025-12-09T04:01:01.880708Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit CreateCdcStream
2025-12-09T04:01:01.880709Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit AlterCdcStream
2025-12-09T04:01:01.880710Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit CreateCdcStream
2025-12-09T04:01:01.880712Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880713Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880714Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit CreateCdcStream
2025-12-09T04:01:01.880715Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit AlterCdcStream
2025-12-09T04:01:01.880715Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit AlterCdcStream
2025-12-09T04:01:01.880717Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit DropCdcStream
2025-12-09T04:01:01.880717Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit AlterCdcStream
2025-12-09T04:01:01.880719Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit DropCdcStream
2025-12-09T04:01:01.880721Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880722Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880723Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit DropCdcStream
2025-12-09T04:01:01.880724Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit AlterCdcStream
2025-12-09T04:01:01.880725Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit RotateCdcStream
2025-12-09T04:01:01.880726Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit DropCdcStream
2025-12-09T04:01:01.880727Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit RotateCdcStream
2025-12-09T04:01:01.880727Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit DropCdcStream
2025-12-09T04:01:01.880729Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880729Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880731Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit DropCdcStream
2025-12-09T04:01:01.880731Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit RotateCdcStream
2025-12-09T04:01:01.880733Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit CreateIncrementalRestoreSrc
2025-12-09T04:01:01.880733Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit RotateCdcStream
2025-12-09T04:01:01.880735Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit CreateIncrementalRestoreSrc
2025-12-09T04:01:01.880735Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit RotateCdcStream
2025-12-09T04:01:01.880737Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880738Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880739Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit RotateCdcStream
2025-12-09T04:01:01.880740Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit CreateIncrementalRestoreSrc
2025-12-09T04:01:01.880741Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit CreateIncrementalRestoreSrc
2025-12-09T04:01:01.880742Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit CompleteOperation
2025-12-09T04:01:01.880743Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit CreateIncrementalRestoreSrc
2025-12-09T04:01:01.880744Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit CompleteOperation
2025-12-09T04:01:01.880745Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880747Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit CreateIncrementalRestoreSrc
2025-12-09T04:01:01.880751Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit CompleteOperation
2025-12-09T04:01:01.880753Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit CompleteOperation
2025-12-09T04:01:01.880773Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is DelayComplete
2025-12-09T04:01:01.880775Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit CompleteOperation
2025-12-09T04:01:01.880776Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037890 to execution unit CompletedOperations
2025-12-09T04:01:01.880778Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037890 on unit CompletedOperations
2025-12-09T04:01:01.880780Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is DelayComplete
2025-12-09T04:01:01.880781Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037890 is Executed
2025-12-09T04:01:01.880782Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit CompleteOperation
2025-12-09T04:01:01.880783Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037890 executing on unit CompletedOperations
2025-12-09T04:01:01.880783Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037893 to execution unit CompletedOperations
2025-12-09T04:01:01.880785Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1938: Execution plan for [1765252861925:281474976715658] at 72075186224037890 has finished
2025-12-09T04:01:01.880785Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037893 on unit CompletedOperations
2025-12-09T04:01:01.880786Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037890 (dry run) active 0 active planned 0 immediate 0 planned 0
2025-12-09T04:01:01.880788Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037890
2025-12-09T04:01:01.880788Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037893 is Executed
2025-12-09T04:01:01.880789Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037890 has no attached operations
2025-12-09T04:01:01.880790Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037893 executing on unit CompletedOperations
2025-12-09T04:01:01.880790Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:341: Unit PlanQueue has no ready operations at 72075186224037890
2025-12-09T04:01:01.880791Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1938: Execution plan for [1765252861925:281474976715658] at 72075186224037893 has finished
2025-12-09T04:01:01.880794Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037893 (dry run) active 0 active planned 0 immediate 0 planned 0
2025-12-09T04:01:01.880795Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037893
2025-12-09T04:01:01.880796Z node 7 :TX_DATASHARD TRACE: plan_queue_unit.cpp:59: TPlanQueueUnit at 72075186224037893 has no attached operations
2025-12-09T04:01:01.880797Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:341: Unit PlanQueue has no ready operations at 72075186224037893
2025-12-09T04:01:01.881029Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 270270976, Sender [7:7581703308827076730:2075], Recipient [7:7581703308827077903:2327]: {TEvRegisterTabletResult TabletId# 72075186224037893 Entry# 1765252861924}
2025-12-09T04:01:01.881031Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3182: StateWork, processing event TEvMediatorTimecast::TEvRegisterTabletResult
2025-12-09T04:01:01.881031Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 270270976, Sender [7:7581703308827076730:2075], Recipient [7:7581703308827077897:2322]: {TEvRegisterTabletResult TabletId# 72075186224037890 Entry# 1765252861924}
2025-12-09T04:01:01.881033Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3182: StateWork, processing event TEvMediatorTimecast::TEvRegisterTabletResult
2025-12-09T04:01:01.881033Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3752: Got TEvMediatorTimecast::TEvRegisterTabletResult at 72075186224037893 time 1765252861924
2025-12-09T04:01:01.881034Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3752: Got TEvMediatorTimecast::TEvRegisterTabletResult at 72075186224037890 time 1765252861924
2025-12-09T04:01:01.881035Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037893
2025-12-09T04:01:01.881035Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037890
2025-12-09T04:01:01.881044Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827078252:2958], Recipient [7:7581703308827077902:2326]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.881044Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269877761, Sender [7:7581703308827078251:2957], Recipient [7:7581703308827077901:2325]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.881046Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.881046Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3180: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-12-09T04:01:01.881049Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037895, clientId# [7:7581703308827078239:2945], serverId# [7:7581703308827078251:2957], sessionId# [0:0:0]
2025-12-09T04:01:01.881049Z node 7 :TX_DATASHARD DEBUG: datashard.cpp:3720: Server connected at leader tablet# 72075186224037897, clientId# [7:7581703308827078241:2947], serverId# [7:7581703308827078252:2958], sessionId# [0:0:0]
2025-12-09T04:01:01.881054Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269287424, Sender [7:7581703308827077408:2381], Recipient [7:7581703308827077901:2325]: {TEvPlanStep step# 1765252861925 MediatorId# 72057594046382081 TabletID 72075186224037895}
2025-12-09T04:01:01.881054Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 269287424, Sender [7:7581703308827077408:2381], Recipient [7:7581703308827077902:2326]: {TEvPlanStep step# 1765252861925 MediatorId# 72057594046382081 TabletID 72075186224037897}
2025-12-09T04:01:01.881055Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3162: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-12-09T04:01:01.881055Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3162: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-12-09T04:01:01.881068Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1806: Trying to execute [1765252861925:281474976715658] at 72075186224037895 on unit WaitForPlan
2025-12-09T04:01:01.881068Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1806: Trying to execute [1765252861925:281474976715658] at 72075186224037897 on unit WaitForPlan
2025-12-09T04:01:01.881070Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1821: Execution status for [1765252861925:281474976715658] at 72075186224037895 is Executed
2025-12-09T04:01:01.881070Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1821: Execution status for [1765252861925:281474976715658] at 72075186224037897 is Executed
2025-12-09T04:01:01.881072Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037895 executing on unit WaitForPlan
2025-12-09T04:01:01.881072Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037897 executing on unit WaitForPlan
2025-12-09T04:01:01.881074Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037897 to execution unit PlanQueue
2025-12-09T04:01:01.881075Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037895 to execution unit PlanQueue
2025-12-09T04:01:01.881096Z node 7 :TX_DATASHARD DEBUG: datashard__plan_step.cpp:69: Planned transaction txId 281474976715658 at step 1765252861925 at tablet 72075186224037895 { Transactions { TxId: 281474976715658 AckTo { RawX1: 0 RawX2: 0 } } Step: 1765252861925 MediatorID: 72057594046382081 TabletID: 72075186224037895 }
2025-12-09T04:01:01.881096Z node 7 :TX_DATASHARD DEBUG: datashard__plan_step.cpp:69: Planned transaction txId 281474976715658 at step 1765252861925 at tablet 72075186224037897 { Transactions { TxId: 281474976715658 AckTo { RawX1: 0 RawX2: 0 } } Step: 1765252861925 MediatorID: 72057594046382081 TabletID: 72075186224037897 }
2025-12-09T04:01:01.881097Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037897
2025-12-09T04:01:01.881097Z node 7 :TX_DATASHARD DEBUG: cdc_stream_heartbeat.cpp:87: [CdcStreamHeartbeat] Emit heartbeats: at tablet# 72075186224037895
2025-12-09T04:01:01.881113Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077902:2326], Recipient [7:7581703308827077902:2326]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.881115Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.881117Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037897
2025-12-09T04:01:01.881117Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3144: StateWork, received event# 2146435072, Sender [7:7581703308827077901:2325], Recipient [7:7581703308827077901:2325]: NKikimr::NDataShard::TDataShard::TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.881119Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037897 active 0 active planned 0 immediate 0 planned 1
2025-12-09T04:01:01.881119Z node 7 :TX_DATASHARD TRACE: datashard_impl.h:3169: StateWork, processing event TEvPrivate::TEvProgressTransaction
2025-12-09T04:01:01.881120Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037897
2025-12-09T04:01:01.881122Z node 7 :TX_DATASHARD DEBUG: datashard__progress_tx.cpp:16: TTxProgressTransaction::Execute at 72075186224037895
2025-12-09T04:01:01.881124Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:333: Found ready operation [1765252861925:281474976715658] in PlanQueue unit at 72075186224037897
2025-12-09T04:01:01.881124Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:272: GetNextActiveOp at 72075186224037895 active 0 active planned 0 immediate 0 planned 1
2025-12-09T04:01:01.881125Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:327: Check candidate unit PlanQueue at 72075186224037895
2025-12-09T04:01:01.881126Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037897 on unit PlanQueue
2025-12-09T04:01:01.881127Z node 7 :TX_DATASHARD DEBUG: datashard_pipeline.cpp:333: Found ready operation [1765252861925:281474976715658] in PlanQueue unit at 72075186224037895
2025-12-09T04:01:01.881128Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037897 is Executed
2025-12-09T04:01:01.881129Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1843: Trying to execute [1765252861925:281474976715658] at 72075186224037895 on unit PlanQueue
2025-12-09T04:01:01.881132Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1878: Execution status for [1765252861925:281474976715658] at 72075186224037895 is Executed
2025-12-09T04:01:01.881132Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037897 executing on unit PlanQueue
2025-12-09T04:01:01.881133Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1932: Add [1765252861925:281474976715658] at 72075186224037897 to execution unit LoadTxDetails
2025-12-09T04:01:01.881133Z node 7 :TX_DATASHARD TRACE: datashard_pipeline.cpp:1926: Advance execution plan for [1765252861925:281474976715658] at 72075186224037895 executing on unit PlanQueue
