2025-10-15T10:39:50.470292Z node 40 :METADATA_PROVIDER WARN: log.cpp:841: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[40:7561396400408919554:2079];send_to=[0:7307199536658146131:7762515];
2025-10-15T10:39:50.470383Z node 40 :METADATA_PROVIDER ERROR: log.cpp:841: fline=accessor_snapshot_base.cpp:71;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=scheme_cache_undelivered_message;
test_client.cpp: SetPath # /home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpqBwHiA/pdisk_1.dat
2025-10-15T10:39:50.512731Z node 40 :KQP_PROXY WARN: kqp_finalize_script_service.cpp:135: [ScriptExecutions] [TKqpFinalizeScriptService] Failed to check script execution tables existence, scheme status: LookupError, path: Root/.metadata/script_executions
2025-10-15T10:39:50.657519Z node 40 :IMPORT WARN: schemeshard_import.cpp:307: Table profiles were not loaded
2025-10-15T10:39:50.681166Z node 40 :KQP_PROXY WARN: kqp_finalize_script_service.cpp:135: [ScriptExecutions] [TKqpFinalizeScriptService] Failed to check script execution tables existence, scheme status: LookupError, path: Root/.metadata/script_executions
2025-10-15T10:39:50.688629Z node 40 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(40, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-10-15T10:39:50.688758Z node 40 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(40, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-10-15T10:39:50.697536Z node 40 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(40, (0,0,0,0)) VolatileState: Connecting -> Connected
TServer::EnableGrpc on GrpcPort 20309, node 40
2025-10-15T10:39:50.778817Z node 40 :NET_CLASSIFIER WARN: net_classifier.cpp:190: distributable config is empty, broken or outdated, will use file: (empty maybe)
2025-10-15T10:39:50.778847Z node 40 :NET_CLASSIFIER WARN: net_classifier.cpp:196: will try to initialize from file: (empty maybe)
2025-10-15T10:39:50.778866Z node 40 :NET_CLASSIFIER WARN: net_classifier.cpp:204: failed to initialize from file: (empty maybe)
2025-10-15T10:39:50.779077Z node 40 :NET_CLASSIFIER ERROR: net_classifier.cpp:228: got bad distributable configuration
2025-10-15T10:39:50.996349Z node 40 :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
TClient is connected to server localhost:27472
WaitRootIsUp 'Root'...
TClient::Ls request: Root
TClient::Ls response: Status: 1
StatusCode: SUCCESS
SchemeStatus: 0
PathDescription {
  Self {
    Name: "Root"
    PathId: 1
    SchemeshardId: 72057594046644480
    PathType: EPathTypeDir
    CreateFinished: true
    CreateTxId: 1
    CreateStep: 0
    ParentPathId: 1
    PathState: EPathStateNoChanges
    Owner: "root@builtin"
    ACL: ""
    EffectiveACL: ""
    PathVersion: 2
    PathSubType: EPathSubTypeEmpty
    Version {
      GeneralVersion: 2
      ACLVersion: 0
      EffectiveACLVersion: 0
      UserAttrsVersion: 1
      ChildrenVersion: 1
      SubDomainVersion: 0
      SecurityStateVersion: 0
    }
    ChildrenExist: false
  }
  Children {
    Name: ".sys"
    PathId: 18446744073709551615
    SchemeshardId: 72057594046644480
    PathType: EPathTypeDir
    CreateFinished: true
    CreateTxId: 0
    CreateStep: 0
    ParentPathId: 18446744073709551615
  }
  DomainDescription {
    SchemeShardId_Depricated: 72057594046644480
    PathId_Depricated: 1
    ProcessingParams {
      Version: 0
      Pl...
(TRUNCATED)
WaitRootIsUp 'Root' success.
2025-10-15T10:39:51.245407Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 281474976710657:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_alter_subdomain.cpp:311)
waiting...
2025-10-15T10:39:51.478682Z node 40 :TX_CONVEYOR ERROR: log.cpp:841: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-10-15T10:39:55.470751Z node 40 :METADATA_PROVIDER ERROR: log.cpp:841: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[40:7561396400408919554:2079];send_to=[0:7307199536658146131:7762515];
2025-10-15T10:39:55.470860Z node 40 :METADATA_PROVIDER ERROR: log.cpp:841: fline=accessor_snapshot_base.cpp:71;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=timeout;
2025-10-15T10:39:55.817293Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpModifyACL, opId: 281474976710658:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_modify_acl.cpp:101)
2025-10-15T10:39:55.872160Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710659:2, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:684)
2025-10-15T10:39:56.930643Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpModifyACL, opId: 281474976710666: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_modify_acl.cpp:101)
2025-10-15T10:39:57.727371Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710669:1, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:684)
2025-10-15T10:39:58.628679Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710674:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:684)
2025-10-15T10:39:59.640131Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpModifyACL, opId: 281474976710679: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_modify_acl.cpp:101)
2025-10-15T10:40:00.470095Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpModifyACL, opId: 281474976710682: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_modify_acl.cpp:101)
2025-10-15T10:40:01.354076Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpInitiateBuildIndexImplTable, opId: 281474976715758:2, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:684)
2025-10-15T10:40:01.513556Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpFinalizeBuildIndexMainTable, opId: 281474976715759: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_finalize_build_index.cpp:383)
2025-10-15T10:40:05.182320Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710708:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:684)
2025-10-15T10:40:05.349182Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateReplication, opId: 281474976710709: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_replication.cpp:487)
2025-10-15T10:40:05.614433Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard_impl.cpp:7712: Cannot get console configs
2025-10-15T10:40:05.614469Z node 40 :IMPORT WARN: schemeshard_import.cpp:307: Table profiles were not loaded
2025-10-15T10:40:05.893156Z node 40 :CHANGE_EXCHANGE WARN: change_sender_cdc_stream.cpp:398: [CdcChangeSenderMain][72075186224037892:1][40:7561396464833432708:2735] Failed entry at 'ResolveTopic': entry# { Path:  TableId: [72057594046644480:13:0] RequestType: ByTableId Operation: OpTopic RedirectRequired: true ShowPrivatePath: true SyncVersion: false Status: PathErrorUnknown Kind: KindUnknown DomainInfo <null> }
2025-10-15T10:40:05.951535Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterPersQueueGroup, opId: 281474976710716: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_pq.cpp:313)
2025-10-15T10:40:06.049232Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710717:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:684)
2025-10-15T10:40:06.158823Z node 40 :PQ_READ_PROXY ERROR: grpc_pq_schema.cpp:148: new Describe topic request
Backup "/Root" to "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/"Create temporary directory "/Root/~backup_20251015T104006" in databaseProcess "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/table"Process "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/replication"Backup async replication "/Root/replication" to "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/replication"Write async replication into "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/replication/create_async_replication.sql"Write ACL into "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/replication/permissions.pb"Process "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/replica"Copy tables: { src: "/Root/table", dst: "/Root/~backup_20251015T104006/table" }, { src: "/Root/replica", dst: "/Root/~backup_20251015T104006/replica" }Describe table "/Root/table"Describe table "/Root/~backup_20251015T104006/table"Backup table "/Root/~backup_20251015T104006/table" to "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/table"Write scheme into "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/table/scheme.pb"Write ACL into "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/table/permissions.pb"Read table "/Root/~backup_20251015T104006/table"Write data into "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/table/data_00.csv"Drop table "/Root/~backup_20251015T104006/table"Describe table "/Root/replica"2025-10-15T10:40:07.269302Z node 40 :HIVE WARN: hive_impl.cpp:516: HIVE#72057594037968897 Handle TEvLocal::TEvTabletStatus from node 40, TabletId: 72075186224037897 not found
Skip table "/Root/replica", because it is a replica tableDrop table "/Root/~backup_20251015T104006/replica"Remove temporary directory "/Root/~backup_20251015T104006" in database2025-10-15T10:40:07.375817Z node 40 :HIVE WARN: hive_impl.cpp:516: HIVE#72057594037968897 Handle TEvLocal::TEvTabletStatus from node 40, TabletId: 72075186224037898 not found
2025-10-15T10:40:07.395554Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpRmDir, opId: 281474976710728: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_rmdir.cpp:66)
Backup completed successfully2025-10-15T10:40:09.987266Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpDropReplicationCascade, opId: 281474976710746: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_drop_replication.cpp:359)
2025-10-15T10:40:10.009745Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpDropPersQueueGroup, opId: 281474976710747:2, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_drop_pq.cpp:422)
2025-10-15T10:40:10.032149Z node 40 :HIVE WARN: hive_impl.cpp:516: HIVE#72057594037968897 Handle TEvLocal::TEvTabletStatus from node 40, TabletId: 72075186224037895 not found
2025-10-15T10:40:10.032199Z node 40 :HIVE WARN: hive_impl.cpp:516: HIVE#72057594037968897 Handle TEvLocal::TEvTabletStatus from node 40, TabletId: 72075186224037894 not found
2025-10-15T10:40:10.044151Z node 40 :HIVE WARN: tx__delete_tablet.cpp:91: HIVE#72057594037968897 THive::TTxDeleteTablet tablet (72057594046644480,8) wasn't found
2025-10-15T10:40:10.044274Z node 40 :HIVE WARN: tx__delete_tablet.cpp:91: HIVE#72057594037968897 THive::TTxDeleteTablet tablet (72057594046644480,7) wasn't found
2025-10-15T10:40:10.102193Z node 40 :HIVE WARN: hive_impl.cpp:516: HIVE#72057594037968897 Handle TEvLocal::TEvTabletStatus from node 40, TabletId: 72075186224037896 not found
2025-10-15T10:40:10.103803Z node 40 :HIVE WARN: hive_impl.cpp:516: HIVE#72057594037968897 Handle TEvLocal::TEvTabletStatus from node 40, TabletId: 72075186224037893 not found
Restore "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/" to "/Root"Resolved db base path: "/Root"List of entries in the backup: [{"fsPath":"/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/","dbPath":"/Root","type":"Directory"},{"fsPath":"/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/table","dbPath":"/Root/table","type":"Table"},{"fsPath":"/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/replication","dbPath":"/Root/replication","type":"Replication"}]Process "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/"Restore directory "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/" to "/Root"Process "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/table"Read scheme from "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/table/scheme.pb"Restore table "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/table" to "/Root/table"2025-10-15T10:40:10.209044Z node 40 :TX_PROXY ERROR: schemereq.cpp:590: Actor# [40:7561396486308271165:5590] txid# 281474976710749, issues: { message: "Check failed: path: \'/Root/table\', error: path exist, request accepts it (id: [OwnerId: 72057594046644480, LocalPathId: 10], type: EPathTypeTable, state: EPathStateNoChanges)" severity: 1 }
Created "/Root/table"Read data from "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/table/data_00.csv"Process "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/replication"Restore async replication "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/replication" to "/Root/replication"Read async replication from "/home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/replication/create_async_replication.sql"Check existence of the secret "secret"2025-10-15T10:40:10.278169Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710750:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:684)
2025-10-15T10:40:11.253578Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710757:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:684)
2025-10-15T10:40:12.178728Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpModifyACL, opId: 281474976710762: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_modify_acl.cpp:101)
2025-10-15T10:40:13.141347Z node 40 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpModifyACL, opId: 281474976710769: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_modify_acl.cpp:101)
2025-10-15T10:40:15.370586Z node 40 :KQP_SESSION WARN: kqp_session_actor.cpp:2843: SessionId: ydb://session/3?node_id=40&id=Y2I5Y2VlMjMtOTNmZjcyN2ItMWFjYmQ2NDktOTE5ZDA2ZGU=, ActorId: [40:7561396486308271180:2986], ActorState: ExecuteState, TraceId: 01k7kq9e0361hz8qz5ptgvxjmn, Create QueryResponse for error on request, msg: 
Restore failed: [ { <main>: Info: path: /home/runner/.ya/build/build_root/d2dv/001fda/r3tmp/tmpZblFS0/replication } { <main>: Error: Secret "secret" does not exist or you do not have access permissions } ]Cleanup2025-10-15T10:40:15.453432Z node 40 :TX_PROXY ERROR: schemereq.cpp:1177: Actor# [40:7561396507783108826:6214] txid# 281474976710783, Access denied for root@builtin on path /Root/.metadata/secrets/access_history, with access RemoveSchema
2025-10-15T10:40:15.453682Z node 40 :TX_PROXY ERROR: schemereq.cpp:590: Actor# [40:7561396507783108826:6214] txid# 281474976710783, issues: { message: "Access denied for root@builtin on path /Root/.metadata/secrets/access_history" issue_code: 200000 severity: 1 }
Error on cleanup, issues: { <main>: Error: Access denied for root@builtin on path /Root/.metadata/secrets/access_history, code: 200000 }
