2025-12-12T07:49:50.510973Z node 28 :METADATA_PROVIDER WARN: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[28:7582875529375620434:2083];send_to=[0:7307199536658146131:7762515];
2025-12-12T07:49:50.511040Z node 28 :METADATA_PROVIDER ERROR: 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/tg4z/0015d2/r3tmp/tmpHiUaz7/pdisk_1.dat
2025-12-12T07:49:50.863895Z node 28 :IMPORT WARN: Table profiles were not loaded
2025-12-12T07:49:50.910024Z node 28 :HIVE WARN: HIVE#72057594037968897 Node(28, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-12-12T07:49:50.910119Z node 28 :HIVE WARN: HIVE#72057594037968897 Node(28, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-12-12T07:49:50.913479Z node 28 :HIVE WARN: HIVE#72057594037968897 Node(28, (0,0,0,0)) VolatileState: Connecting -> Connected
TServer::EnableGrpc on GrpcPort 15317, node 28
2025-12-12T07:49:51.074648Z node 28 :NET_CLASSIFIER WARN: distributable config is empty, broken or outdated, will use file: (empty maybe)
2025-12-12T07:49:51.074673Z node 28 :NET_CLASSIFIER WARN: will try to initialize from file: (empty maybe)
2025-12-12T07:49:51.074681Z node 28 :NET_CLASSIFIER WARN: failed to initialize from file: (empty maybe)
2025-12-12T07:49:51.074816Z node 28 :NET_CLASSIFIER ERROR: got bad distributable configuration
TClient is connected to server localhost:12361
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-12-12T07:49:51.363449Z node 28 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 281474976710657:0, at schemeshard:  72057594046644480
waiting...
2025-12-12T07:49:54.498850Z node 28 :KQP_WORKLOAD_SERVICE WARN: [WorkloadService] [TPoolFetcherActor] ActorId: [28:7582875546555490668:2340], DatabaseId: /Root, PoolId: default, Failed to fetch pool info, NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-12T07:49:54.498850Z node 28 :KQP_WORKLOAD_SERVICE WARN: [WorkloadService] [TPoolFetcherActor] ActorId: [28:7582875546555490676:2343], DatabaseId: /Root, PoolId: default, Failed to fetch pool info, NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-12T07:49:54.498928Z node 28 :KQP_WORKLOAD_SERVICE WARN: [WorkloadService] [Service] Failed to fetch pool default, DatabaseId: /Root, status: NOT_FOUND, issues: { <main>: Error: Resource pool default not found or you don't have access permissions }
2025-12-12T07:49:54.499158Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Handle TEvProposeTransaction
2025-12-12T07:49:54.499178Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] TxId# 281474976710658 ProcessProposeTransaction
2025-12-12T07:49:54.499212Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Cookie# 0 userReqId# "" txid# 281474976710658 SEND to# [28:7582875546555490683:2612]
2025-12-12T07:49:54.501311Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490683:2612] txid# 281474976710658 Bootstrap EvSchemeRequest record: Transaction { ModifyScheme { WorkingDir: "/Root/.metadata/workload_manager/pools" OperationType: ESchemeOpCreateResourcePool ModifyACL { Name: "default" DiffACL: "\n!\010\000\022\035\010\001\020\201\004\032\024all-users@well-known \003\n\031\010\000\022\025\010\001\020\201\004\032\014root@builtin \003" NewOwner: "metadata@system" } Internal: true CreateResourcePool { Name: "default" Properties { Properties { key: "concurrent_query_limit" value: "-1" } Properties { key: "database_load_cpu_threshold" value: "-1" } Properties { key: "query_cancel_after_seconds" value: "0" } Properties { key: "query_cpu_limit_percent_per_node" value: "-1" } Properties { key: "query_memory_limit_percent_per_node" value: "-1" } Properties { key: "queue_size" value: "-1" } Properties { key: "resource_weight" value: "-1" } Properties { key: "total_cpu_limit_percent_per_node" value: "-1" } } } } } UserToken: "\n\017metadata@system\022\000" DatabaseName: "/Root" 
2025-12-12T07:49:54.501355Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490683:2612] txid# 281474976710658 Bootstrap, UserSID: metadata@system CheckAdministrator: 0 CheckDatabaseAdministrator: 0
2025-12-12T07:49:54.501370Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490683:2612] txid# 281474976710658 Bootstrap, UserSID: metadata@system IsClusterAdministrator: 1
2025-12-12T07:49:54.502952Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490683:2612] txid# 281474976710658 HANDLE EvNavigateKeySetResult TFlatSchemeReq marker# P6
2025-12-12T07:49:54.503039Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490683:2612] txid# 281474976710658 TEvNavigateKeySet requested from SchemeCache
2025-12-12T07:49:54.503271Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490683:2612] txid# 281474976710658 HANDLE EvNavigateKeySetResult TFlatSchemeReq marker# P5 ErrorCount# 0
2025-12-12T07:49:54.503403Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490683:2612] HANDLE EvNavigateKeySetResult, txid# 281474976710658 shardToRequest# 72057594046644480 DomainKey# [OwnerId: 72057594046644480, LocalPathId: 1] DomainInfo.Params# Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 RedirectRequired# true
2025-12-12T07:49:54.503455Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490683:2612] txid# 281474976710658 SEND to# 72057594046644480 shardToRequest {TEvModifySchemeTransaction txid# 281474976710658 TabletId# 72057594046644480}
2025-12-12T07:49:54.503587Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490683:2612] txid# 281474976710658 HANDLE EvClientConnected
2025-12-12T07:49:54.504857Z node 28 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateResourcePool, opId: 281474976710658:3, at schemeshard:  72057594046644480
2025-12-12T07:49:54.507165Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490683:2612] txid# 281474976710658 Status StatusAccepted HANDLE {TEvModifySchemeTransactionResult Status# StatusAccepted txid# 281474976710658}
2025-12-12T07:49:54.507216Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490683:2612] txid# 281474976710658 SEND to# [28:7582875546555490682:2344] Source {TEvProposeTransactionStatus txid# 281474976710658 Status# 53}
2025-12-12T07:49:54.522458Z node 28 :KQP_WORKLOAD_SERVICE WARN: [WorkloadService] [TPoolCreatorActor] ActorId: [28:7582875546555490682:2344], DatabaseId: /Root, PoolId: default, Scheduled retry for error: { <main>: Error: Transaction 281474976710658 completed, doublechecking }
2025-12-12T07:49:54.605980Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Handle TEvProposeTransaction
2025-12-12T07:49:54.606026Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] TxId# 281474976710659 ProcessProposeTransaction
2025-12-12T07:49:54.606084Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Cookie# 0 userReqId# "" txid# 281474976710659 SEND to# [28:7582875546555490759:2667]
2025-12-12T07:49:54.608256Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490759:2667] txid# 281474976710659 Bootstrap EvSchemeRequest record: Transaction { ModifyScheme { WorkingDir: "/Root/.metadata/workload_manager/pools" OperationType: ESchemeOpCreateResourcePool ModifyACL { Name: "default" DiffACL: "\n!\010\000\022\035\010\001\020\201\004\032\024all-users@well-known \003\n\031\010\000\022\025\010\001\020\201\004\032\014root@builtin \003" NewOwner: "metadata@system" } Internal: true CreateResourcePool { Name: "default" Properties { Properties { key: "concurrent_query_limit" value: "-1" } Properties { key: "database_load_cpu_threshold" value: "-1" } Properties { key: "query_cancel_after_seconds" value: "0" } Properties { key: "query_cpu_limit_percent_per_node" value: "-1" } Properties { key: "query_memory_limit_percent_per_node" value: "-1" } Properties { key: "queue_size" value: "-1" } Properties { key: "resource_weight" value: "-1" } Properties { key: "total_cpu_limit_percent_per_node" value: "-1" } } } } } UserToken: "\n\017metadata@system\022\000" DatabaseName: "/Root" 
2025-12-12T07:49:54.608326Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490759:2667] txid# 281474976710659 Bootstrap, UserSID: metadata@system CheckAdministrator: 0 CheckDatabaseAdministrator: 0
2025-12-12T07:49:54.608346Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490759:2667] txid# 281474976710659 Bootstrap, UserSID: metadata@system IsClusterAdministrator: 1
2025-12-12T07:49:54.609021Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490759:2667] txid# 281474976710659 HANDLE EvNavigateKeySetResult TFlatSchemeReq marker# P6
2025-12-12T07:49:54.609165Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490759:2667] txid# 281474976710659 TEvNavigateKeySet requested from SchemeCache
2025-12-12T07:49:54.609406Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490759:2667] txid# 281474976710659 HANDLE EvNavigateKeySetResult TFlatSchemeReq marker# P5 ErrorCount# 0
2025-12-12T07:49:54.609561Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490759:2667] HANDLE EvNavigateKeySetResult, txid# 281474976710659 shardToRequest# 72057594046644480 DomainKey# [OwnerId: 72057594046644480, LocalPathId: 1] DomainInfo.Params# Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 RedirectRequired# true
2025-12-12T07:49:54.609616Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490759:2667] txid# 281474976710659 SEND to# 72057594046644480 shardToRequest {TEvModifySchemeTransaction txid# 281474976710659 TabletId# 72057594046644480}
2025-12-12T07:49:54.609800Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490759:2667] txid# 281474976710659 HANDLE EvClientConnected
2025-12-12T07:49:54.616540Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490759:2667] txid# 281474976710659 Status StatusAlreadyExists HANDLE {TEvModifySchemeTransactionResult Status# StatusAlreadyExists txid# 281474976710659 Reason# Check failed: path: '/Root/.metadata/workload_manager/pools/default', error: path exist, request accepts it (id: [OwnerId: 72057594046644480, LocalPathId: 5], type: EPathTypeResourcePool, state: EPathStateNoChanges)}
2025-12-12T07:49:54.616702Z node 28 :TX_PROXY ERROR: Actor# [28:7582875546555490759:2667] txid# 281474976710659, issues: { message: "Check failed: path: \'/Root/.metadata/workload_manager/pools/default\', error: path exist, request accepts it (id: [OwnerId: 72057594046644480, LocalPathId: 5], type: EPathTypeResourcePool, state: EPathStateNoChanges)" severity: 1 }
2025-12-12T07:49:54.616738Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490759:2667] txid# 281474976710659 SEND to# [28:7582875546555490682:2344] Source {TEvProposeTransactionStatus txid# 281474976710659 Status# 48}
2025-12-12T07:49:54.637411Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Handle TEvProposeTransaction
2025-12-12T07:49:54.637443Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] TxId# 281474976710660 ProcessProposeTransaction
2025-12-12T07:49:54.637489Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Cookie# 0 userReqId# "" txid# 281474976710660 SEND to# [28:7582875546555490792:2680]
2025-12-12T07:49:54.640095Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490792:2680] txid# 281474976710660 Bootstrap EvSchemeRequest record: Transaction { ModifyScheme { WorkingDir: "/Root" OperationType: ESchemeOpCreateTable CreateTable { Name: "JsonDocumentTable" Columns { Name: "Key" Type: "JsonDocument" NotNull: false } Columns { Name: "Value" Type: "Int32" NotNull: false } KeyColumnNames: "Key" PartitionConfig { } Temporary: false } FailedOnAlreadyExists: true } } UserToken: "" DatabaseName: "" RequestType: "" PeerName: "ipv6:[::1]:59696" 
2025-12-12T07:49:54.640148Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490792:2680] txid# 281474976710660 Bootstrap, UserSID: <empty> CheckAdministrator: 0 CheckDatabaseAdministrator: 0
2025-12-12T07:49:54.640481Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490792:2680] txid# 281474976710660 HANDLE EvNavigateKeySetResult TFlatSchemeReq marker# P6
2025-12-12T07:49:54.640545Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490792:2680] txid# 281474976710660 TEvNavigateKeySet requested from SchemeCache
2025-12-12T07:49:54.640708Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490792:2680] txid# 281474976710660 HANDLE EvNavigateKeySetResult TFlatSchemeReq marker# P5 ErrorCount# 0
2025-12-12T07:49:54.640797Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490792:2680] HANDLE EvNavigateKeySetResult, txid# 281474976710660 shardToRequest# 72057594046644480 DomainKey# [OwnerId: 72057594046644480, LocalPathId: 1] DomainInfo.Params# Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 RedirectRequired# true
2025-12-12T07:49:54.640831Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490792:2680] txid# 281474976710660 SEND to# 72057594046644480 shardToRequest {TEvModifySchemeTransaction txid# 281474976710660 TabletId# 72057594046644480}
2025-12-12T07:49:54.640953Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490792:2680] txid# 281474976710660 HANDLE EvClientConnected
2025-12-12T07:49:54.643825Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490792:2680] txid# 281474976710660 Status StatusSchemeError HANDLE {TEvModifySchemeTransactionResult Status# StatusSchemeError txid# 281474976710660 Reason# Column Key has wrong key type JsonDocument}
2025-12-12T07:49:54.643948Z node 28 :TX_PROXY ERROR: Actor# [28:7582875546555490792:2680] txid# 281474976710660, issues: { message: "Column Key has wrong key type JsonDocument" severity: 1 }
2025-12-12T07:49:54.643984Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490792:2680] txid# 281474976710660 SEND to# [28:7582875546555490791:2337] Source {TEvProposeTransactionStatus txid# 281474976710660 Status# 52}
2025-12-12T07:49:54.644258Z node 28 :KQP_SESSION WARN: SessionId: ydb://session/3?node_id=28&id=MzRmNDA3ZGUtZGNjYjg1M2UtMjMzOWU1YjYtYmY1MDBkMjE=, ActorId: [28:7582875546555490664:2337], ActorState: ExecuteState, TraceId: 01kc8rkbp1exey8jvwxr0pd5x6, Create QueryResponse for error on request, msg: 
2025-12-12T07:49:54.644504Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Handle TEvExecuteKqpTransaction
2025-12-12T07:49:54.644529Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] TxId# 281474976710661 ProcessProposeKqpTransaction
2025-12-12T07:49:54.644945Z node 28 :KQP_EXECUTER ERROR: TxId: 281474976710661. Ctx: { TraceId: 01kc8rkbp1exey8jvwxr0pd5x6, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=28&id=MzRmNDA3ZGUtZGNjYjg1M2UtMjMzOWU1YjYtYmY1MDBkMjE=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: default}. Database not set, use /Root
2025-12-12T07:49:54.667330Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Handle TEvProposeTransaction
2025-12-12T07:49:54.667362Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] TxId# 281474976710662 ProcessProposeTransaction
2025-12-12T07:49:54.667413Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Cookie# 0 userReqId# "" txid# 281474976710662 SEND to# [28:7582875546555490820:2693]
2025-12-12T07:49:54.670038Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490820:2693] txid# 281474976710662 Bootstrap EvSchemeRequest record: Transaction { ModifyScheme { WorkingDir: "/Root" OperationType: ESchemeOpCreateTable CreateTable { Name: "JsonDocumentTable" Columns { Name: "Key" Type: "Int32" NotNull: false } Columns { Name: "Value" Type: "JsonDocument" NotNull: false } KeyColumnNames: "Key" PartitionConfig { } Temporary: false } FailedOnAlreadyExists: true } } UserToken: "" DatabaseName: "" RequestType: "" PeerName: "ipv6:[::1]:59696" 
2025-12-12T07:49:54.670087Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490820:2693] txid# 281474976710662 Bootstrap, UserSID: <empty> CheckAdministrator: 0 CheckDatabaseAdministrator: 0
2025-12-12T07:49:54.670462Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490820:2693] txid# 281474976710662 HANDLE EvNavigateKeySetResult TFlatSchemeReq marker# P6
2025-12-12T07:49:54.670541Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490820:2693] txid# 281474976710662 TEvNavigateKeySet requested from SchemeCache
2025-12-12T07:49:54.670769Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490820:2693] txid# 281474976710662 HANDLE EvNavigateKeySetResult TFlatSchemeReq marker# P5 ErrorCount# 0
2025-12-12T07:49:54.670896Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490820:2693] HANDLE EvNavigateKeySetResult, txid# 281474976710662 shardToRequest# 72057594046644480 DomainKey# [OwnerId: 72057594046644480, LocalPathId: 1] DomainInfo.Params# Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 RedirectRequired# true
2025-12-12T07:49:54.670938Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490820:2693] txid# 281474976710662 SEND to# 72057594046644480 shardToRequest {TEvModifySchemeTransaction txid# 281474976710662 TabletId# 72057594046644480}
2025-12-12T07:49:54.671063Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490820:2693] txid# 281474976710662 HANDLE EvClientConnected
2025-12-12T07:49:54.672057Z node 28 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710662:0, at schemeshard:  72057594046644480
2025-12-12T07:49:54.674097Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490820:2693] txid# 281474976710662 Status StatusAccepted HANDLE {TEvModifySchemeTransactionResult Status# StatusAccepted txid# 281474976710662}
2025-12-12T07:49:54.674152Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875546555490820:2693] txid# 281474976710662 SEND to# [28:7582875546555490819:2337] Source {TEvProposeTransactionStatus txid# 281474976710662 Status# 53}
2025-12-12T07:49:54.841215Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Handle TEvExecuteKqpTransaction
2025-12-12T07:49:54.841241Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] TxId# 281474976710663 ProcessProposeKqpTransaction
2025-12-12T07:49:54.841956Z node 28 :KQP_EXECUTER ERROR: TxId: 281474976710663. Ctx: { TraceId: 01kc8rkby98rtwgd7r5r466pha, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=28&id=MzRmNDA3ZGUtZGNjYjg1M2UtMjMzOWU1YjYtYmY1MDBkMjE=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: default}. Database not set, use /Root
2025-12-12T07:49:54.986696Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Handle TEvExecuteKqpTransaction
2025-12-12T07:49:54.986734Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] TxId# 281474976710664 ProcessProposeKqpTransaction
2025-12-12T07:49:54.987496Z node 28 :KQP_EXECUTER ERROR: TxId: 281474976710664. Ctx: { TraceId: 01kc8rkc14f7meqzgdpk83hmac, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=28&id=MzRmNDA3ZGUtZGNjYjg1M2UtMjMzOWU1YjYtYmY1MDBkMjE=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: default}. Database not set, use /Root
2025-12-12T07:49:55.011827Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Handle TEvNavigate  describe path /Root
2025-12-12T07:49:55.011880Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875550850458304:2826] HANDLE EvNavigateScheme /Root
2025-12-12T07:49:55.012202Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875550850458304:2826] HANDLE EvNavigateKeySetResult TDescribeReq marker# P5 ErrorCount# 0
2025-12-12T07:49:55.012292Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875550850458304:2826] SEND to# 72057594046644480 shardToRequest NKikimrSchemeOp.TDescribePath Path: "/Root" Options { ShowPrivateTable: false }
2025-12-12T07:49:55.012946Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875550850458304:2826] Handle TEvDescribeSchemeResult Forward to# [28:7582875550850458302:2377] Cookie: 0 TEvDescribeSchemeResult: NKikimrScheme.TEvDescribeSchemeResult PreSerializedData size# 148 Record# Status: StatusSuccess Path: "/Root" PathDescription { Self { Name: "Root" PathId: 1 SchemeshardId: 72057594046644480 PathType: EPathTypeDir CreateFinished: true CreateTxId: 1 CreateStep: 1765525791428 ParentPathId: 1 PathState: EPathStateNoChanges Owner: "root@builtin" ACL: "" EffectiveACL: "" PathVersion: 8 PathSubType: EPathSubTypeEmpty Version { GeneralVersion: 8 ACLVersion: 0 EffectiveACLVersion: 0 UserAttrsVersion: 1 ChildrenVersion: 6 SubDomainVersion: 1 SecurityStateVersion: 0 } ChildrenExist: true } DomainDescription { SchemeShardId_Depricated: 72057594046644480 PathId_Depricated: 1 ProcessingParams { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } DomainKey { SchemeShard: 72057594046644480 PathId: 1 } StoragePools { Name: "/Root:test" Kind: "test" } StoragePools { Name: "hdd" Kind: "hdd" } StoragePools { Name: "hdd1" Kind: "hdd1" } StoragePools { Name: "hdd2" Kind: "hdd2" } StoragePools { Name: "ssd" Kind: "ssd" } PathsInside: 5 PathsLimit: 10000 ShardsInside: 1 ShardsLimit: 200000 ResourcesDomainKey { SchemeShard: 72057594046644480 PathId: 1 } DiskSpaceUsage { Tables { TotalSize: 0 DataSize: 0 IndexSize: 0 } Topics { ReserveSize: 0 AccountSize: 0 DataSize: 0 UsedReserveSize: 0 } } PQPartitionsInside: 0 PQPartitionsLimit: 1000000 SecurityState { Audience: "/Root" } } } PathId: 1 PathOwnerId: 72057594046644480
2025-12-12T07:49:55.019714Z node 28 :TX_PROXY DEBUG: [CreateExport] [28:7582875550850458309:2378] [0] Handle TEvTxProxySchemeCache::TEvNavigateKeySetResult: request# { ErrorCount: 0 DatabaseName: /Root DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root TableId: [72057594046644480:1:0] RequestType: ByPath Operation: OpPath RedirectRequired: true ShowPrivatePath: false SyncVersion: false Status: Ok Kind: KindPath DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) Users: [] Groups: [] } },{ Path: Root/JsonDocumentTable TableId: [72057594046644480:6:1] RequestType: ByPath Operation: OpPath RedirectRequired: true ShowPrivatePath: false SyncVersion: false Status: Ok Kind: KindTable DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) Users: [] Groups: [] } }] }
2025-12-12T07:49:55.019737Z node 28 :TX_PROXY DEBUG: [CreateExport] [28:7582875550850458309:2378] [0] Allocate txId
2025-12-12T07:49:55.019797Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Handle TEvAllocateTxId
2025-12-12T07:49:55.019873Z node 28 :TX_PROXY DEBUG: [CreateExport] [28:7582875550850458309:2378] [281474976710665] TEvTxUserProxy::TEvAllocateTxIdResult
2025-12-12T07:49:55.019890Z node 28 :TX_PROXY DEBUG: [CreateExport] [28:7582875550850458309:2378] [281474976710665] Resolve database: name# /Root
2025-12-12T07:49:55.020146Z node 28 :TX_PROXY DEBUG: [CreateExport] [28:7582875550850458309:2378] [281474976710665] Handle TEvTxProxySchemeCache::TEvNavigateKeySetResult: request# { ErrorCount: 0 DatabaseName: /Root DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root TableId: [72057594046644480:1:0] RequestType: ByPath Operation: OpPath RedirectRequired: true ShowPrivatePath: false SyncVersion: false Status: Ok Kind: KindPath DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) Users: [] Groups: [] } }] }
2025-12-12T07:49:55.020180Z node 28 :TX_PROXY DEBUG: [CreateExport] [28:7582875550850458309:2378] [281474976710665] Send request: schemeShardId# 72057594046644480
2025-12-12T07:49:55.020509Z node 28 :EXPORT DEBUG: TExport::TTxCreate: DoExecute
2025-12-12T07:49:55.020802Z node 28 :EXPORT DEBUG: TExport::TTxCreate: Reply: status# SUCCESS, error# 
2025-12-12T07:49:55.022605Z node 28 :EXPORT DEBUG: TExport::TTxCreate: DoComplete
2025-12-12T07:49:55.022715Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoExecute
2025-12-12T07:49:55.022737Z node 28 :EXPORT DEBUG: TExport::TTxProgress: Resume: id# 281474976710665
2025-12-12T07:49:55.022795Z node 28 :EXPORT INFO: TExport::TTxProgress: Allocate txId: info# { Id: 281474976710665 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] ExportPathId: <Invalid> UserSID: '(empty maybe)' PeerName: 'ipv6:[::1]:59702' State: CreateExportDir WaitTxId: 0 Issue: '' Items: 1 PendingItems: 1 PendingDropItems: 0 }
2025-12-12T07:49:55.022842Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoComplete
2025-12-12T07:49:55.022846Z node 28 :TX_PROXY DEBUG: [CreateExport] [28:7582875550850458309:2378] [281474976710665] Handle TEvExport::TEvCreateExportResponse: record# Entry { Id: 281474976710665 Status: SUCCESS Progress: PROGRESS_PREPARING ExportToS3Settings { endpoint: "localhost:21053" scheme: HTTP bucket: "test_bucket" items { source_path: "/Root/JsonDocumentTable" destination_prefix: "/JsonDocumentTable" } } StartTime { seconds: 1765525795 } }
2025-12-12T07:49:55.022913Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoExecute
2025-12-12T07:49:55.022929Z node 28 :EXPORT DEBUG: TExport::TTxProgress: OnAllocateResult: txId# 281474976715757, id# 281474976710665
2025-12-12T07:49:55.022963Z node 28 :EXPORT INFO: TExport::TTxProgress: MkDir propose: info# { Id: 281474976710665 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] ExportPathId: <Invalid> UserSID: '(empty maybe)' PeerName: 'ipv6:[::1]:59702' State: CreateExportDir WaitTxId: 0 Issue: '' Items: 1 PendingItems: 1 PendingDropItems: 0 }, txId# 281474976715757
2025-12-12T07:49:55.023027Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoComplete
2025-12-12T07:49:55.025539Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoExecute
2025-12-12T07:49:55.025560Z node 28 :EXPORT DEBUG: TExport::TTxProgress: OnModifyResult: txId# 281474976715757, status# StatusAccepted
2025-12-12T07:49:55.025682Z node 28 :EXPORT INFO: TExport::TTxProgress: Wait for completion: info# { Id: 281474976710665 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] ExportPathId: [OwnerId: 72057594046644480, LocalPathId: 7] UserSID: '(empty maybe)' PeerName: 'ipv6:[::1]:59702' State: CreateExportDir WaitTxId: 281474976715757 Issue: '' Items: 1 PendingItems: 1 PendingDropItems: 0 }, itemIdx# 4294967295, txId# 281474976715757
2025-12-12T07:49:55.028269Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoComplete
2025-12-12T07:49:55.028741Z node 28 :TX_PROXY DEBUG: [GetExport] [28:7582875550850458334:2379] [0] Resolve database: name# /Root
2025-12-12T07:49:55.029042Z node 28 :TX_PROXY DEBUG: [GetExport] [28:7582875550850458334:2379] [0] Handle TEvTxProxySchemeCache::TEvNavigateKeySetResult: request# { ErrorCount: 0 DatabaseName: /Root DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root TableId: [72057594046644480:1:0] RequestType: ByPath Operation: OpPath RedirectRequired: true ShowPrivatePath: false SyncVersion: false Status: Ok Kind: KindPath DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) Users: [] Groups: [] } }] }
2025-12-12T07:49:55.029068Z node 28 :TX_PROXY DEBUG: [GetExport] [28:7582875550850458334:2379] [0] Send request: schemeShardId# 72057594046644480
2025-12-12T07:49:55.029663Z node 28 :TX_PROXY DEBUG: [GetExport] [28:7582875550850458334:2379] [0] Handle TEvExport::TEvGetExportResponse: record# Entry { Id: 281474976710665 Status: SUCCESS Progress: PROGRESS_PREPARING ExportToS3Settings { endpoint: "localhost:21053" scheme: HTTP bucket: "test_bucket" items { source_path: "/Root/JsonDocumentTable" destination_prefix: "/JsonDocumentTable" } } StartTime { seconds: 1765525795 } }
2025-12-12T07:49:55.035108Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoExecute
2025-12-12T07:49:55.035132Z node 28 :EXPORT DEBUG: TExport::TTxProgress: OnNotifyResult: txId# 281474976715757
2025-12-12T07:49:55.035146Z node 28 :EXPORT DEBUG: TExport::TTxProgress: OnNotifyResult: txId# 281474976715757, id# 281474976710665, itemIdx# 4294967295
2025-12-12T07:49:55.035201Z node 28 :EXPORT INFO: TExport::TTxProgress: Allocate txId: info# { Id: 281474976710665 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] ExportPathId: [OwnerId: 72057594046644480, LocalPathId: 7] UserSID: '(empty maybe)' PeerName: 'ipv6:[::1]:59702' State: CopyTables WaitTxId: 0 Issue: '' Items: 1 PendingItems: 1 PendingDropItems: 0 }
2025-12-12T07:49:55.036334Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoComplete
2025-12-12T07:49:55.036413Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoExecute
2025-12-12T07:49:55.036425Z node 28 :EXPORT DEBUG: TExport::TTxProgress: OnAllocateResult: txId# 281474976715758, id# 281474976710665
2025-12-12T07:49:55.036460Z node 28 :EXPORT INFO: TExport::TTxProgress: CopyTables propose: info# { Id: 281474976710665 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] ExportPathId: [OwnerId: 72057594046644480, LocalPathId: 7] UserSID: '(empty maybe)' PeerName: 'ipv6:[::1]:59702' State: CopyTables WaitTxId: 0 Issue: '' Items: 1 PendingItems: 1 PendingDropItems: 0 }, txId# 281474976715758
2025-12-12T07:49:55.036526Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoComplete
2025-12-12T07:49:55.039971Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoExecute
2025-12-12T07:49:55.039998Z node 28 :EXPORT DEBUG: TExport::TTxProgress: OnModifyResult: txId# 281474976715758, status# StatusAccepted
2025-12-12T07:49:55.040078Z node 28 :EXPORT INFO: TExport::TTxProgress: Wait for completion: info# { Id: 281474976710665 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] ExportPathId: [OwnerId: 72057594046644480, LocalPathId: 7] UserSID: '(empty maybe)' PeerName: 'ipv6:[::1]:59702' State: CopyTables WaitTxId: 281474976715758 Issue: '' Items: 1 PendingItems: 1 PendingDropItems: 0 }, itemIdx# 4294967295, txId# 281474976715758
2025-12-12T07:49:55.042660Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoComplete
2025-12-12T07:49:55.108721Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoExecute
2025-12-12T07:49:55.108753Z node 28 :EXPORT DEBUG: TExport::TTxProgress: OnNotifyResult: txId# 281474976715758
2025-12-12T07:49:55.108772Z node 28 :EXPORT DEBUG: TExport::TTxProgress: OnNotifyResult: txId# 281474976715758, id# 281474976710665, itemIdx# 4294967295
2025-12-12T07:49:55.108917Z node 28 :EXPORT INFO: TExport::TTxProgress: Allocate txId: info# { Id: 281474976710665 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] ExportPathId: [OwnerId: 72057594046644480, LocalPathId: 7] UserSID: '(empty maybe)' PeerName: 'ipv6:[::1]:59702' State: Transferring WaitTxId: 0 Issue: '' Items: 1 PendingItems: 1 PendingDropItems: 0 }, item# { Idx: 0 SourcePathName: '/Root/JsonDocumentTable' SourcePathId: [OwnerId: 72057594046644480, LocalPathId: 6] SourcePathType: EPathTypeTable State: Transferring SubState: AllocateTxId WaitTxId: 0 Issue: '' }
2025-12-12T07:49:55.110715Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoComplete
2025-12-12T07:49:55.110835Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoExecute
2025-12-12T07:49:55.110851Z node 28 :EXPORT DEBUG: TExport::TTxProgress: OnAllocateResult: txId# 281474976715759, id# 281474976710665
2025-12-12T07:49:55.110921Z node 28 :EXPORT INFO: TExport::TTxProgress: Backup propose: info# { Id: 281474976710665 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] ExportPathId: [OwnerId: 72057594046644480, LocalPathId: 7] UserSID: '(empty maybe)' PeerName: 'ipv6:[::1]:59702' State: Transferring WaitTxId: 0 Issue: '' Items: 1 PendingItems: 0 PendingDropItems: 0 }, item# { Idx: 0 SourcePathName: '/Root/JsonDocumentTable' SourcePathId: [OwnerId: 72057594046644480, LocalPathId: 6] SourcePathType: EPathTypeTable State: Transferring SubState: Proposed WaitTxId: 0 Issue: '' }, txId# 281474976715759
2025-12-12T07:49:55.112946Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoComplete
2025-12-12T07:49:55.113926Z node 28 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpBackup, opId: 281474976715759:0, at schemeshard:  72057594046644480
2025-12-12T07:49:55.116249Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoExecute
2025-12-12T07:49:55.116270Z node 28 :EXPORT DEBUG: TExport::TTxProgress: OnModifyResult: txId# 281474976715759, status# StatusAccepted
2025-12-12T07:49:55.116343Z node 28 :EXPORT INFO: TExport::TTxProgress: Wait for completion: info# { Id: 281474976710665 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] ExportPathId: [OwnerId: 72057594046644480, LocalPathId: 7] UserSID: '(empty maybe)' PeerName: 'ipv6:[::1]:59702' State: Transferring WaitTxId: 0 Issue: '' Items: 1 PendingItems: 0 PendingDropItems: 0 }, itemIdx# 0, txId# 281474976715759
2025-12-12T07:49:55.118087Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoComplete
REQUEST: PUT /test_bucket/JsonDocumentTable/metadata.json HTTP/1.1
HEADERS: 
Host: localhost:21053
Accept: */*
Connection: Upgrade, HTTP2-Settings
Upgrade: h2c
HTTP2-Settings: AAMAAABkAAQAoAAAAAIAAAAA
amz-sdk-invocation-id: 91A6366F-91CB-45D7-AEA7-6A7C485C57C4
amz-sdk-request: attempt=1
authorization: AWS4-HMAC-SHA256 Credential=test_key/20251212/us-east-1/s3/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;content-length;content-md5;content-type;host;x-amz-content-sha256;x-amz-date, Signature=35b15006a41b3bf976f5742095bb817209e72ae6f9151375056dd4b1bc353538
content-length: 79
content-md5: k/N0e6p7wxYKl3Q0mZP65w==
content-type: binary/octet-stream
user-agent: aws-sdk-cpp/1.11.37 Linux/5.15.0-157-generic x86_64 Clang/18.1.8
x-amz-content-sha256: 7ff4dde4976f155352832f6971b3fa7126db566c5458b812ef6bfaea933325d1
x-amz-date: 20251212T074955Z
S3_MOCK::HttpServeWrite: /test_bucket/JsonDocumentTable/metadata.json /  / 79
REQUEST: PUT /test_bucket/JsonDocumentTable/scheme.pb HTTP/1.1
HEADERS: 
Host: localhost:21053
Accept: */*
Connection: Upgrade, HTTP2-Settings
Upgrade: h2c
HTTP2-Settings: AAMAAABkAAQAoAAAAAIAAAAA
amz-sdk-invocation-id: 5CCFECF1-0DA0-44BB-98AC-1E57948336FA
amz-sdk-request: attempt=1
authorization: AWS4-HMAC-SHA256 Credential=test_key/20251212/us-east-1/s3/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;content-length;content-md5;content-type;host;x-amz-content-sha256;x-amz-date, Signature=24660b5ecc83b2f8d6227a24455f48d00654dd9a32fd0e5e7b3b45feb7831a7d
content-length: 365
content-md5: u9YeYspGoamt3wjVx1B84w==
content-type: binary/octet-stream
user-agent: aws-sdk-cpp/1.11.37 Linux/5.15.0-157-generic x86_64 Clang/18.1.8
x-amz-content-sha256: f39b7f8f1512b6b062e686ed53aacf171d7d6bfd71248604a9131bb8e1e7b4fd
x-amz-date: 20251212T074955Z
S3_MOCK::HttpServeWrite: /test_bucket/JsonDocumentTable/scheme.pb /  / 365
REQUEST: PUT /test_bucket/JsonDocumentTable/data_00.csv HTTP/1.1
HEADERS: 
Host: localhost:21053
Accept: */*
Connection: Upgrade, HTTP2-Settings
Upgrade: h2c
HTTP2-Settings: AAMAAABkAAQAoAAAAAIAAAAA
amz-sdk-invocation-id: ADD68C47-60E0-4778-9A08-60C610F23E2C
amz-sdk-request: attempt=1
authorization: AWS4-HMAC-SHA256 Credential=test_key/20251212/us-east-1/s3/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;content-length;content-md5;content-type;host;x-amz-content-sha256;x-amz-date, Signature=cc04b1254ce49fb3147b634464bf95b7a17fff665eac031a6a2feb55ad82fa94
content-length: 32
content-md5: /aUzmC4zPniPqgrNxDRdsw==
content-type: binary/octet-stream
user-agent: aws-sdk-cpp/1.11.37 Linux/5.15.0-157-generic x86_64 Clang/18.1.8
x-amz-content-sha256: bca8f77fd073a09fccf7af7dfa810aa5dd3f62386ea4d04489053b58eb5d6a1e
x-amz-date: 20251212T074955Z
S3_MOCK::HttpServeWrite: /test_bucket/JsonDocumentTable/data_00.csv /  / 32
2025-12-12T07:49:55.210919Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoExecute
2025-12-12T07:49:55.210943Z node 28 :EXPORT DEBUG: TExport::TTxProgress: OnNotifyResult: txId# 281474976715759
2025-12-12T07:49:55.210952Z node 28 :EXPORT DEBUG: TExport::TTxProgress: OnNotifyResult: txId# 281474976715759, id# 281474976710665, itemIdx# 0
2025-12-12T07:49:55.214402Z node 28 :EXPORT DEBUG: TExport::TTxProgress: DoComplete
2025-12-12T07:49:55.239634Z node 28 :TX_PROXY DEBUG: [GetExport] [28:7582875550850458577:2385] [0] Resolve database: name# /Root
2025-12-12T07:49:55.240060Z node 28 :TX_PROXY DEBUG: [GetExport] [28:7582875550850458577:2385] [0] Handle TEvTxProxySchemeCache::TEvNavigateKeySetResult: request# { ErrorCount: 0 DatabaseName: /Root DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root TableId: [72057594046644480:1:0] RequestType: ByPath Operation: OpPath RedirectRequired: true ShowPrivatePath: false SyncVersion: false Status: Ok Kind: KindPath DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) Users: [] Groups: [] } }] }
2025-12-12T07:49:55.240083Z node 28 :TX_PROXY DEBUG: [GetExport] [28:7582875550850458577:2385] [0] Send request: schemeShardId# 72057594046644480
2025-12-12T07:49:55.240865Z node 28 :TX_PROXY DEBUG: [GetExport] [28:7582875550850458577:2385] [0] Handle TEvExport::TEvGetExportResponse: record# Entry { Id: 281474976710665 Status: SUCCESS Progress: PROGRESS_DONE ExportToS3Settings { endpoint: "localhost:21053" scheme: HTTP bucket: "test_bucket" items { source_path: "/Root/JsonDocumentTable" destination_prefix: "/JsonDocumentTable" } } ItemsProgress { parts_total: 1 parts_completed: 1 start_time { seconds: 1765525795 } end_time { seconds: 1765525795 } } StartTime { seconds: 1765525795 } EndTime { seconds: 1765525795 } }
2025-12-12T07:49:55.286437Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Handle TEvProposeTransaction
2025-12-12T07:49:55.286474Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] TxId# 281474976710666 ProcessProposeTransaction
2025-12-12T07:49:55.286524Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Cookie# 0 userReqId# "" txid# 281474976710666 SEND to# [28:7582875550850458593:3065]
2025-12-12T07:49:55.289278Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875550850458593:3065] txid# 281474976710666 Bootstrap EvSchemeRequest record: Transaction { ModifyScheme { WorkingDir: "/Root" OperationType: ESchemeOpDropTable Drop { Name: "JsonDocumentTable" } SuccessOnNotExist: false } } UserToken: "" DatabaseName: "" RequestType: "" PeerName: "ipv6:[::1]:59696" 
2025-12-12T07:49:55.289314Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875550850458593:3065] txid# 281474976710666 Bootstrap, UserSID: <empty> CheckAdministrator: 0 CheckDatabaseAdministrator: 0
2025-12-12T07:49:55.289376Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875550850458593:3065] txid# 281474976710666 TEvNavigateKeySet requested from SchemeCache
2025-12-12T07:49:55.289679Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875550850458593:3065] txid# 281474976710666 HANDLE EvNavigateKeySetResult TFlatSchemeReq marker# P5 ErrorCount# 0
2025-12-12T07:49:55.289793Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875550850458593:3065] HANDLE EvNavigateKeySetResult, txid# 281474976710666 shardToRequest# 72057594046644480 DomainKey# [OwnerId: 72057594046644480, LocalPathId: 1] DomainInfo.Params# Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 RedirectRequired# true
2025-12-12T07:49:55.289837Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875550850458593:3065] txid# 281474976710666 SEND to# 72057594046644480 shardToRequest {TEvModifySchemeTransaction txid# 281474976710666 TabletId# 72057594046644480}
2025-12-12T07:49:55.290003Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875550850458593:3065] txid# 281474976710666 HANDLE EvClientConnected
2025-12-12T07:49:55.292741Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875550850458593:3065] txid# 281474976710666 Status StatusAccepted HANDLE {TEvModifySchemeTransactionResult Status# StatusAccepted txid# 281474976710666}
2025-12-12T07:49:55.292790Z node 28 :TX_PROXY DEBUG: Actor# [28:7582875550850458593:3065] txid# 281474976710666 SEND to# [28:7582875550850458592:2337] Source {TEvProposeTransactionStatus txid# 281474976710666 Status# 53}
2025-12-12T07:49:55.333830Z node 28 :TX_PROXY DEBUG: [CreateImport] [28:7582875550850458665:2394] [0] Allocate txId
2025-12-12T07:49:55.333917Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Handle TEvAllocateTxId
2025-12-12T07:49:55.333978Z node 28 :TX_PROXY DEBUG: [CreateImport] [28:7582875550850458665:2394] [281474976710667] TEvTxUserProxy::TEvAllocateTxIdResult
2025-12-12T07:49:55.334024Z node 28 :TX_PROXY DEBUG: [CreateImport] [28:7582875550850458665:2394] [281474976710667] Resolve database: name# /Root
2025-12-12T07:49:55.334330Z node 28 :TX_PROXY DEBUG: [CreateImport] [28:7582875550850458665:2394] [281474976710667] Handle TEvTxProxySchemeCache::TEvNavigateKeySetResult: request# { ErrorCount: 0 DatabaseName: /Root DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root TableId: [72057594046644480:1:0] RequestType: ByPath Operation: OpPath RedirectRequired: true ShowPrivatePath: false SyncVersion: false Status: Ok Kind: KindPath DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) Users: [] Groups: [] } }] }
2025-12-12T07:49:55.334361Z node 28 :TX_PROXY DEBUG: [CreateImport] [28:7582875550850458665:2394] [281474976710667] Send request: schemeShardId# 72057594046644480
2025-12-12T07:49:55.334845Z node 28 :IMPORT DEBUG: TImport::TTxCreate: DoExecute
2025-12-12T07:49:55.335198Z node 28 :IMPORT DEBUG: TImport::TTxCreate: Reply: status# SUCCESS, error# 
2025-12-12T07:49:55.338790Z node 28 :IMPORT DEBUG: TImport::TTxCreate: DoComplete
2025-12-12T07:49:55.338929Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoExecute
2025-12-12T07:49:55.338947Z node 28 :IMPORT DEBUG: TImport::TTxProgress: Resume: id# 281474976710667, itemIdx# (empty maybe)
2025-12-12T07:49:55.339017Z node 28 :IMPORT DEBUG: TImport::TTxProgress: Resume: info# { Id: 281474976710667 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] UserSID: '(empty maybe)' State: Waiting Issue: '' Items: 1 }, item# { Idx: 0 DstPathName: '/Root/JsonDocumentTable' DstPathId: <Invalid> State: GetScheme SubState: AllocateTxId WaitTxId: 0 Issue: '' }
2025-12-12T07:49:55.339053Z node 28 :IMPORT INFO: TImport::TTxProgress: Get scheme: info# { Id: 281474976710667 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] UserSID: '(empty maybe)' State: Waiting Issue: '' Items: 1 }, item# { Idx: 0 DstPathName: '/Root/JsonDocumentTable' DstPathId: <Invalid> State: GetScheme SubState: AllocateTxId WaitTxId: 0 Issue: '' }
2025-12-12T07:49:55.339077Z node 28 :TX_PROXY DEBUG: [CreateImport] [28:7582875550850458665:2394] [281474976710667] Handle TEvImport::TEvCreateImportResponse: record# Entry { Id: 281474976710667 Status: SUCCESS Progress: PROGRESS_PREPARING ImportFromS3Settings { endpoint: "localhost:21053" scheme: HTTP bucket: "test_bucket" items { source_prefix: "JsonDocumentTable" destination_path: "/Root/JsonDocumentTable" } } StartTime { seconds: 1765525795 } }
2025-12-12T07:49:55.339209Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoComplete
2025-12-12T07:49:55.347755Z node 28 :TX_PROXY DEBUG: [GetImport] [28:7582875550850458673:2395] [0] Resolve database: name# /Root
2025-12-12T07:49:55.348174Z node 28 :TX_PROXY DEBUG: [GetImport] [28:7582875550850458673:2395] [0] Handle TEvTxProxySchemeCache::TEvNavigateKeySetResult: request# { ErrorCount: 0 DatabaseName: /Root DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root TableId: [72057594046644480:1:0] RequestType: ByPath Operation: OpPath RedirectRequired: true ShowPrivatePath: false SyncVersion: false Status: Ok Kind: KindPath DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) Users: [] Groups: [] } }] }
2025-12-12T07:49:55.348215Z node 28 :TX_PROXY DEBUG: [GetImport] [28:7582875550850458673:2395] [0] Send request: schemeShardId# 72057594046644480
2025-12-12T07:49:55.376345Z node 28 :TX_PROXY DEBUG: [GetImport] [28:7582875550850458673:2395] [0] Handle TEvImport::TEvGetImportResponse: record# Entry { Id: 281474976710667 Status: SUCCESS Progress: PROGRESS_PREPARING ImportFromS3Settings { endpoint: "localhost:21053" scheme: HTTP bucket: "test_bucket" items { source_prefix: "JsonDocumentTable" destination_path: "/Root/JsonDocumentTable" } } StartTime { seconds: 1765525795 } }
2025-12-12T07:49:55.378346Z node 28 :METADATA_PROVIDER ERROR: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[28:7582875529375620434:2083];send_to=[0:7307199536658146131:7762515];
2025-12-12T07:49:55.378422Z node 28 :METADATA_PROVIDER ERROR: fline=accessor_snapshot_base.cpp:71;action=cannot detect path existence;path=//Root/.metadata/initialization/migrations;error=timeout;
REQUEST: HEAD /test_bucket/JsonDocumentTable/metadata.json HTTP/1.1
HEADERS: 
Host: localhost:21053
Accept: */*
Connection: Upgrade, HTTP2-Settings
Upgrade: h2c
HTTP2-Settings: AAMAAABkAAQAoAAAAAIAAAAA
amz-sdk-invocation-id: D6E2AA04-7812-4034-9DE3-8A1C4A95B09C
amz-sdk-request: attempt=1
authorization: AWS4-HMAC-SHA256 Credential=test_key/20251212/us-east-1/s3/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;content-type;host;x-amz-api-version;x-amz-content-sha256;x-amz-date, Signature=6d0eb0cebc1003f3773076b831521b05f689e38ad94e0a0c6d1bae1a9f419431
content-type: application/xml
user-agent: aws-sdk-cpp/1.11.37 Linux/5.15.0-157-generic x86_64 Clang/18.1.8
x-amz-api-version: 2006-03-01
x-amz-content-sha256: e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date: 20251212T074955Z
S3_MOCK::HttpServeRead: /test_bucket/JsonDocumentTable/metadata.json / 79
2025-12-12T07:49:55.382974Z node 28 :IMPORT DEBUG: HandleMetadata TEvExternalStorage::TEvHeadObjectResponse: self# [28:7582875550850458672:2218], result# HeadObjectResult { ETag: 93f3747baa7bc3160a9774349993fae7 ContentLength: 79 }
REQUEST: GET /test_bucket/JsonDocumentTable/metadata.json HTTP/1.1
HEADERS: 
Host: localhost:21053
Accept: */*
Connection: Upgrade, HTTP2-Settings
Upgrade: h2c
HTTP2-Settings: AAMAAABkAAQAoAAAAAIAAAAA
amz-sdk-invocation-id: E7B22210-675C-47E1-B8C3-54CD5374A0FA
amz-sdk-request: attempt=1
authorization: AWS4-HMAC-SHA256 Credential=test_key/20251212/us-east-1/s3/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;content-type;host;range;x-amz-api-version;x-amz-content-sha256;x-amz-date, Signature=4fc8b0648ce89f6487f8f949f89b617c81928db7679e3d39c7e1a3e1e3341eb1
content-type: application/xml
range: bytes=0-78
user-agent: aws-sdk-cpp/1.11.37 Linux/5.15.0-157-generic x86_64 Clang/18.1.8
x-amz-api-version: 2006-03-01
x-amz-content-sha256: e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date: 20251212T074955Z
S3_MOCK::HttpServeRead: /test_bucket/JsonDocumentTable/metadata.json / 79
2025-12-12T07:49:55.388950Z node 28 :IMPORT DEBUG: HandleMetadata TEvExternalStorage::TEvGetObjectResponse: self# [28:7582875550850458672:2218], result# 93f3747baa7bc3160a9774349993fae7
REQUEST: HEAD /test_bucket/JsonDocumentTable/scheme.pb HTTP/1.1
HEADERS: 
Host: localhost:21053
Accept: */*
Connection: Upgrade, HTTP2-Settings
Upgrade: h2c
HTTP2-Settings: AAMAAABkAAQAoAAAAAIAAAAA
amz-sdk-invocation-id: 6DA27D60-B8F7-49D1-BC62-CE41401064EB
amz-sdk-request: attempt=1
authorization: AWS4-HMAC-SHA256 Credential=test_key/20251212/us-east-1/s3/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;content-type;host;x-amz-api-version;x-amz-content-sha256;x-amz-date, Signature=14540d931828674f5347472740998e7dc7b5f8b4f581b159a664411c821aedac
content-type: application/xml
user-agent: aws-sdk-cpp/1.11.37 Linux/5.15.0-157-generic x86_64 Clang/18.1.8
x-amz-api-version: 2006-03-01
x-amz-content-sha256: e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date: 20251212T074955Z
S3_MOCK::HttpServeRead: /test_bucket/JsonDocumentTable/scheme.pb / 365
2025-12-12T07:49:55.445554Z node 28 :IMPORT DEBUG: HandleScheme TEvExternalStorage::TEvHeadObjectResponse: self# [28:7582875550850458672:2218], result# HeadObjectResult { ETag: bbd61e62ca46a1a9addf08d5c7507ce3 ContentLength: 365 }
REQUEST: GET /test_bucket/JsonDocumentTable/scheme.pb HTTP/1.1
HEADERS: 
Host: localhost:21053
Accept: */*
Connection: Upgrade, HTTP2-Settings
Upgrade: h2c
HTTP2-Settings: AAMAAABkAAQAoAAAAAIAAAAA
amz-sdk-invocation-id: C649F22A-9708-4C2E-B498-CF8058A42A56
amz-sdk-request: attempt=1
authorization: AWS4-HMAC-SHA256 Credential=test_key/20251212/us-east-1/s3/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;content-type;host;range;x-amz-api-version;x-amz-content-sha256;x-amz-date, Signature=a7f1279acb2f74d980687006db4246b78a3ded256c6ee7f80db6f3b085415f4e
content-type: application/xml
range: bytes=0-364
user-agent: aws-sdk-cpp/1.11.37 Linux/5.15.0-157-generic x86_64 Clang/18.1.8
x-amz-api-version: 2006-03-01
x-amz-content-sha256: e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date: 20251212T074955Z
S3_MOCK::HttpServeRead: /test_bucket/JsonDocumentTable/scheme.pb / 365
2025-12-12T07:49:55.458507Z node 28 :IMPORT DEBUG: HandleScheme TEvExternalStorage::TEvGetObjectResponse: self# [28:7582875550850458672:2218], result# bbd61e62ca46a1a9addf08d5c7507ce3
REQUEST: HEAD /test_bucket/JsonDocumentTable/permissions.pb HTTP/1.1
HEADERS: 
Host: localhost:21053
Accept: */*
Connection: Upgrade, HTTP2-Settings
Upgrade: h2c
HTTP2-Settings: AAMAAABkAAQAoAAAAAIAAAAA
amz-sdk-invocation-id: 6F4C8C1B-5AE4-4647-A4FD-EB58BDBC8006
amz-sdk-request: attempt=1
authorization: AWS4-HMAC-SHA256 Credential=test_key/20251212/us-east-1/s3/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;content-type;host;x-amz-api-version;x-amz-content-sha256;x-amz-date, Signature=cb4d157da128d1066fe73c64ced035097bb591e8ff4a882a44be4561cd8b1c6c
content-type: application/xml
user-agent: aws-sdk-cpp/1.11.37 Linux/5.15.0-157-generic x86_64 Clang/18.1.8
x-amz-api-version: 2006-03-01
x-amz-content-sha256: e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date: 20251212T074955Z
2025-12-12T07:49:55.515388Z node 28 :IMPORT DEBUG: HandlePermissions TEvExternalStorage::TEvHeadObjectResponse: self# [28:7582875550850458672:2218], result# No response body.
REQUEST: GET /test_bucket?prefix=JsonDocumentTable HTTP/1.1
HEADERS: 
Host: localhost:21053
Accept: */*
Connection: Upgrade, HTTP2-Settings
Upgrade: h2c
HTTP2-Settings: AAMAAABkAAQAoAAAAAIAAAAA
amz-sdk-invocation-id: 22002B46-C2AA-4042-8871-115A9C9DE439
amz-sdk-request: attempt=1
authorization: AWS4-HMAC-SHA256 Credential=test_key/20251212/us-east-1/s3/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;content-type;host;x-amz-api-version;x-amz-content-sha256;x-amz-date, Signature=d51e548429b6596e56ee018ccc1a7ec1c2e4151e0147d533bbcfdd1442d2c2bd
content-type: application/xml
user-agent: aws-sdk-cpp/1.11.37 Linux/5.15.0-157-generic x86_64 Clang/18.1.8
x-amz-api-version: 2006-03-01
x-amz-content-sha256: e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date: 20251212T074955Z
S3_MOCK::HttpServeList: JsonDocumentTable
2025-12-12T07:49:55.584712Z node 28 :IMPORT DEBUG: HandleChangefeeds TEvExternalStorage::TEvListObjectResponse: self# [28:7582875550850458672:2218], result# ListObjectsResult { }
2025-12-12T07:49:55.584796Z node 28 :IMPORT INFO: Reply: self# [28:7582875550850458672:2218], success# 1, error# 
2025-12-12T07:49:55.584914Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoExecute
2025-12-12T07:49:55.584946Z node 28 :IMPORT DEBUG: TImport::TTxProgress: OnSchemeResult: id# 281474976710667, itemIdx# 0, success# 1
2025-12-12T07:49:55.585376Z node 28 :IMPORT INFO: TImport::TTxProgress: Allocate txId: info# { Id: 281474976710667 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] UserSID: '(empty maybe)' State: Waiting Issue: '' Items: 1 }, item# { Idx: 0 DstPathName: '/Root/JsonDocumentTable' DstPathId: <Invalid> State: CreateSchemeObject SubState: AllocateTxId WaitTxId: 0 Issue: '' }
2025-12-12T07:49:55.587426Z node 28 :TX_PROXY DEBUG: [GetImport] [28:7582875550850458690:2398] [0] Resolve database: name# /Root
2025-12-12T07:49:55.597312Z node 28 :TX_PROXY DEBUG: [GetImport] [28:7582875550850458690:2398] [0] Handle TEvTxProxySchemeCache::TEvNavigateKeySetResult: request# { ErrorCount: 0 DatabaseName: /Root DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root TableId: [72057594046644480:1:0] RequestType: ByPath Operation: OpPath RedirectRequired: true ShowPrivatePath: false SyncVersion: false Status: Ok Kind: KindPath DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) Users: [] Groups: [] } }] }
2025-12-12T07:49:55.597339Z node 28 :TX_PROXY DEBUG: [GetImport] [28:7582875550850458690:2398] [0] Send request: schemeShardId# 72057594046644480
2025-12-12T07:49:55.597563Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoComplete
2025-12-12T07:49:55.597654Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoExecute
2025-12-12T07:49:55.597670Z node 28 :IMPORT DEBUG: TImport::TTxProgress: OnAllocateResult: txId# 281474976715760, id# 281474976710667
2025-12-12T07:49:55.597777Z node 28 :IMPORT INFO: TImport::TTxProgress: CreateTable propose: info# { Id: 281474976710667 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] UserSID: '(empty maybe)' State: Waiting Issue: '' Items: 1 }, item# { Idx: 0 DstPathName: '/Root/JsonDocumentTable' DstPathId: <Invalid> State: CreateSchemeObject SubState: Proposed WaitTxId: 0 Issue: '' }, txId# 281474976715760
2025-12-12T07:49:55.597946Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoComplete
2025-12-12T07:49:55.599171Z node 28 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976715760:0, at schemeshard:  72057594046644480
2025-12-12T07:49:55.603079Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoExecute
2025-12-12T07:49:55.603100Z node 28 :IMPORT DEBUG: TImport::TTxProgress: OnModifyResult: txId# 281474976715760, status# StatusAccepted
2025-12-12T07:49:55.603190Z node 28 :IMPORT INFO: TImport::TTxProgress: Wait for completion: info# { Id: 281474976710667 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] UserSID: '(empty maybe)' State: Waiting Issue: '' Items: 1 }, item# { Idx: 0 DstPathName: '/Root/JsonDocumentTable' DstPathId: [OwnerId: 72057594046644480, LocalPathId: 9] State: CreateSchemeObject SubState: Subscribed WaitTxId: 281474976715760 Issue: '' }
2025-12-12T07:49:55.603951Z node 28 :TX_PROXY DEBUG: [GetImport] [28:7582875550850458690:2398] [0] Handle TEvImport::TEvGetImportResponse: record# Entry { Id: 281474976710667 Status: SUCCESS Progress: PROGRESS_PREPARING ImportFromS3Settings { endpoint: "localhost:21053" scheme: HTTP bucket: "test_bucket" items { source_prefix: "JsonDocumentTable" destination_path: "/Root/JsonDocumentTable" } } StartTime { seconds: 1765525795 } }
2025-12-12T07:49:55.609089Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoComplete
2025-12-12T07:49:55.671959Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoExecute
2025-12-12T07:49:55.671994Z node 28 :IMPORT DEBUG: TImport::TTxProgress: OnNotifyResult: txId# 281474976715760
2025-12-12T07:49:55.672102Z node 28 :IMPORT INFO: TImport::TTxProgress: Allocate txId: info# { Id: 281474976710667 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] UserSID: '(empty maybe)' State: Waiting Issue: '' Items: 1 }, item# { Idx: 0 DstPathName: '/Root/JsonDocumentTable' DstPathId: [OwnerId: 72057594046644480, LocalPathId: 9] State: Transferring SubState: AllocateTxId WaitTxId: 0 Issue: '' }
2025-12-12T07:49:55.673730Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoComplete
2025-12-12T07:49:55.673819Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoExecute
2025-12-12T07:49:55.673835Z node 28 :IMPORT DEBUG: TImport::TTxProgress: OnAllocateResult: txId# 281474976715761, id# 281474976710667
2025-12-12T07:49:55.673898Z node 28 :IMPORT INFO: TImport::TTxProgress: Restore propose: info# { Id: 281474976710667 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] UserSID: '(empty maybe)' State: Waiting Issue: '' Items: 1 }, item# { Idx: 0 DstPathName: '/Root/JsonDocumentTable' DstPathId: [OwnerId: 72057594046644480, LocalPathId: 9] State: Transferring SubState: Proposed WaitTxId: 0 Issue: '' }, txId# 281474976715761
2025-12-12T07:49:55.674535Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoComplete
2025-12-12T07:49:55.674982Z node 28 :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpRestore, opId: 281474976715761:0, at schemeshard:  72057594046644480
2025-12-12T07:49:55.676945Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoExecute
2025-12-12T07:49:55.676968Z node 28 :IMPORT DEBUG: TImport::TTxProgress: OnModifyResult: txId# 281474976715761, status# StatusAccepted
2025-12-12T07:49:55.677046Z node 28 :IMPORT INFO: TImport::TTxProgress: Wait for completion: info# { Id: 281474976710667 Uid: '' Kind: S3 DomainPathId: [OwnerId: 72057594046644480, LocalPathId: 1] UserSID: '(empty maybe)' State: Waiting Issue: '' Items: 1 }, item# { Idx: 0 DstPathName: '/Root/JsonDocumentTable' DstPathId: [OwnerId: 72057594046644480, LocalPathId: 9] State: Transferring SubState: Subscribed WaitTxId: 281474976715761 Issue: '' }
2025-12-12T07:49:55.678519Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoComplete
REQUEST: HEAD /test_bucket/JsonDocumentTable/data_00.csv HTTP/1.1
HEADERS: 
Host: localhost:21053
Accept: */*
Connection: Upgrade, HTTP2-Settings
Upgrade: h2c
HTTP2-Settings: AAMAAABkAAQAoAAAAAIAAAAA
amz-sdk-invocation-id: 4B5C3A65-2B22-4248-9276-1660514F5286
amz-sdk-request: attempt=1
authorization: AWS4-HMAC-SHA256 Credential=test_key/20251212/us-east-1/s3/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;content-type;host;x-amz-api-version;x-amz-content-sha256;x-amz-date, Signature=2506c455054f9d7317baa9794885b08ab2a895e7d7e48dccf62779732556f9f8
content-type: application/xml
user-agent: aws-sdk-cpp/1.11.37 Linux/5.15.0-157-generic x86_64 Clang/18.1.8
x-amz-api-version: 2006-03-01
x-amz-content-sha256: e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date: 20251212T074955Z
S3_MOCK::HttpServeRead: /test_bucket/JsonDocumentTable/data_00.csv / 32
REQUEST: GET /test_bucket/JsonDocumentTable/data_00.csv HTTP/1.1
HEADERS: 
Host: localhost:21053
Accept: */*
Connection: Upgrade, HTTP2-Settings
Upgrade: h2c
HTTP2-Settings: AAMAAABkAAQAoAAAAAIAAAAA
amz-sdk-invocation-id: B1E0420A-0506-404B-9FC8-AFCE3D2D36E1
amz-sdk-request: attempt=1
authorization: AWS4-HMAC-SHA256 Credential=test_key/20251212/us-east-1/s3/aws4_request, SignedHeaders=amz-sdk-invocation-id;amz-sdk-request;content-type;host;range;x-amz-api-version;x-amz-content-sha256;x-amz-date, Signature=413179143e7ea23e800c39604790d8d1be646a72c4ff5892f066a3279394a928
content-type: application/xml
range: bytes=0-31
user-agent: aws-sdk-cpp/1.11.37 Linux/5.15.0-157-generic x86_64 Clang/18.1.8
x-amz-api-version: 2006-03-01
x-amz-content-sha256: e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
x-amz-date: 20251212T074955Z
S3_MOCK::HttpServeRead: /test_bucket/JsonDocumentTable/data_00.csv / 32
2025-12-12T07:49:55.767714Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoExecute
2025-12-12T07:49:55.767757Z node 28 :IMPORT DEBUG: TImport::TTxProgress: OnNotifyResult: txId# 281474976715761
2025-12-12T07:49:55.769424Z node 28 :IMPORT DEBUG: TImport::TTxProgress: DoComplete
2025-12-12T07:49:56.026176Z node 28 :TX_PROXY DEBUG: [GetImport] [28:7582875555145426186:2403] [0] Resolve database: name# /Root
2025-12-12T07:49:56.026617Z node 28 :TX_PROXY DEBUG: [GetImport] [28:7582875555145426186:2403] [0] Handle TEvTxProxySchemeCache::TEvNavigateKeySetResult: request# { ErrorCount: 0 DatabaseName: /Root DomainOwnerId: 0 Instant: 0 ResultSet [{ Path: Root TableId: [72057594046644480:1:0] RequestType: ByPath Operation: OpPath RedirectRequired: true ShowPrivatePath: false SyncVersion: false Status: Ok Kind: KindPath DomainInfo { DomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] ResourcesDomainKey: [OwnerId: 72057594046644480, LocalPathId: 1] Params { Version: 1 PlanResolution: 7 Coordinators: 72057594046316545 TimeCastBucketsPerMediator: 2 Mediators: 72057594046382081 } ServerlessComputeResourcesMode: (empty maybe) Users: [] Groups: [] } }] }
2025-12-12T07:49:56.026638Z node 28 :TX_PROXY DEBUG: [GetImport] [28:7582875555145426186:2403] [0] Send request: schemeShardId# 72057594046644480
2025-12-12T07:49:56.027519Z node 28 :TX_PROXY DEBUG: [GetImport] [28:7582875555145426186:2403] [0] Handle TEvImport::TEvGetImportResponse: record# Entry { Id: 281474976710667 Status: SUCCESS Progress: PROGRESS_DONE ImportFromS3Settings { endpoint: "localhost:21053" scheme: HTTP bucket: "test_bucket" items { source_prefix: "JsonDocumentTable" destination_path: "/Root/JsonDocumentTable" } } StartTime { seconds: 1765525795 } EndTime { seconds: 1765525795 } }
2025-12-12T07:49:56.146972Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] Handle TEvExecuteKqpTransaction
2025-12-12T07:49:56.147013Z node 28 :TX_PROXY DEBUG: actor# [28:7582875529375620437:2111] TxId# 281474976710668 ProcessProposeKqpTransaction
2025-12-12T07:49:56.147950Z node 28 :KQP_EXECUTER ERROR: TxId: 281474976710668. Ctx: { TraceId: 01kc8rkd600jhczhvzbxmxjmbe, Database: , DatabaseId: /Root, SessionId: ydb://session/3?node_id=28&id=MzRmNDA3ZGUtZGNjYjg1M2UtMjMzOWU1YjYtYmY1MDBkMjE=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: default}. Database not set, use /Root
