2025-11-21T15:47:10.762502Z node 10 :METADATA_PROVIDER WARN: log.cpp:841: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[10:7575205751511031534:2076];send_to=[0:7307199536658146131:7762515];
2025-11-21T15:47:10.766739Z node 10 :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;
2025-11-21T15:47:10.882652Z node 12 :BS_NODE WARN: {NWDC01@distconf.cpp:397} StateFunc too long Type# 268639239 Duration# 0.008550s
test_client.cpp: SetPath # /home/runner/.ya/build/build_root/4ogs/001d8a/r3tmp/tmpT4FmNQ/pdisk_1.dat
2025-11-21T15:47:10.951394Z node 10 :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-11-21T15:47:11.214160Z node 10 :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-11-21T15:47:11.326552Z node 10 :IMPORT WARN: schemeshard_import.cpp:307: Table profiles were not loaded
2025-11-21T15:47:11.373059Z node 10 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(10, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-21T15:47:11.373143Z node 10 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(10, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-21T15:47:11.391437Z node 10 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(10, (0,0,0,0)) VolatileState: Connecting -> Connected
TServer::EnableGrpc on GrpcPort 19190, node 10
2025-11-21T15:47:11.672024Z node 10 :NET_CLASSIFIER WARN: net_classifier.cpp:190: distributable config is empty, broken or outdated, will use file: (empty maybe)
2025-11-21T15:47:11.672048Z node 10 :NET_CLASSIFIER WARN: net_classifier.cpp:196: will try to initialize from file: (empty maybe)
2025-11-21T15:47:11.672056Z node 10 :NET_CLASSIFIER WARN: net_classifier.cpp:204: failed to initialize from file: (empty maybe)
2025-11-21T15:47:11.672195Z node 10 :NET_CLASSIFIER ERROR: net_classifier.cpp:228: got bad distributable configuration
2025-11-21T15:47:11.769688Z node 10 :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-11-21T15:47:11.794228Z node 10 :TX_CONVEYOR ERROR: log.cpp:841: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
TClient is connected to server localhost:18992
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-11-21T15:47:12.345459Z node 10 :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-11-21T15:47:12.527506Z node 10 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:646: Got grpc request# CreateTableRequest, traceId# 01kakhj7gfaecycehb84ysmmrm, sdkBuildInfo# undef, state# AS_NOT_PERFORMED, database# undef, peer# ipv6:[::1]:43920, grpcInfo# grpc-c++/1.54.3 grpc-c/31.0.0 (linux; chttp2), timeout# undef
2025-11-21T15:47:12.531211Z node 10 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710658:0, at schemeshard:  72057594046644480, first GetDB called at:  (GetDB first called at /home/runner/actions_runner/_work/ydb/ydb/ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:690)
2025-11-21T15:47:12.555143Z node 10 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:540: SchemeBoardUpdate /Root
2025-11-21T15:47:12.555250Z node 10 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:569: Can't update SecurityState for /Root - no PublicKeys
2025-11-21T15:47:12.555269Z node 10 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:540: SchemeBoardUpdate /Root
2025-11-21T15:47:12.555311Z node 10 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:569: Can't update SecurityState for /Root - no PublicKeys
2025-11-21T15:47:12.801656Z node 10 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:540: SchemeBoardUpdate /Root
2025-11-21T15:47:12.801780Z node 10 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:569: Can't update SecurityState for /Root - no PublicKeys
2025-11-21T15:47:12.801793Z node 10 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:540: SchemeBoardUpdate /Root
2025-11-21T15:47:12.801836Z node 10 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:569: Can't update SecurityState for /Root - no PublicKeys
2025-11-21T15:47:12.869993Z node 10 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:646: Got grpc request# CreateSessionRequest, traceId# 01kakhj7v59qakazsndwvjz5r4, sdkBuildInfo# undef, state# AS_NOT_PERFORMED, database# undef, peer# ipv6:[::1]:43920, grpcInfo# grpc-c++/1.54.3 grpc-c/31.0.0 (linux; chttp2), timeout# undef
2025-11-21T15:47:15.766493Z node 10 :METADATA_PROVIDER ERROR: log.cpp:841: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[10:7575205751511031534:2076];send_to=[0:7307199536658146131:7762515];
2025-11-21T15:47:15.766557Z node 10 :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-11-21T15:47:17.468244Z node 10 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:646: Got grpc request# ExecuteDataQueryRequest, traceId# 01kakhjcaw8ebj2ytwqmwpt9va, sdkBuildInfo# undef, state# AS_NOT_PERFORMED, database# undef, peer# ipv6:[::1]:43920, grpcInfo# grpc-c++/1.54.3 grpc-c/31.0.0 (linux; chttp2), timeout# undef
2025-11-21T15:47:17.784364Z node 10 :KQP_EXECUTER ERROR: kqp_planner.cpp:123: TxId: 281474976710659. Ctx: { TraceId: 01kakhjcaw8ebj2ytwqmwpt9va, Database: , SessionId: ydb://session/3?node_id=10&id=YThlYmU0YWYtZmQ2ZTVlYTEtN2IzMzY3Y2ItYjM1MmViOTI=, PoolId: , DatabaseId: /Root}. Database not set, use /Root
2025-11-21T15:47:17.821021Z node 10 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:646: Got grpc request# ReadTableRequest, traceId# 01kakhjcnw0exze03fs1ypz2p3, sdkBuildInfo# undef, state# AS_NOT_PERFORMED, database# undef, peer# ipv6:[::1]:43920, grpcInfo# grpc-c++/1.54.3 grpc-c/31.0.0 (linux; chttp2), timeout# undef
2025-11-21T15:47:17.821529Z node 10 :READ_TABLE_API NOTICE: rpc_read_table.cpp:531: [10:7575205781575803894:2333] Finish grpc stream, status: 400010
2025-11-21T15:47:17.823553Z node 10 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:646: Got grpc request# ReadTableRequest, traceId# 01kakhjcnzctv7erh83dhdtqej, sdkBuildInfo# undef, state# AS_NOT_PERFORMED, database# undef, peer# ipv6:[::1]:43920, grpcInfo# grpc-c++/1.54.3 grpc-c/31.0.0 (linux; chttp2), timeout# undef
2025-11-21T15:47:17.833654Z node 10 :READ_TABLE_API DEBUG: rpc_read_table.cpp:267: [10:7575205781575803895:2334] Adding quota request to queue ShardId: 0, TxId: 281474976710660
2025-11-21T15:47:17.833706Z node 10 :READ_TABLE_API DEBUG: rpc_read_table.cpp:629: [10:7575205781575803895:2334] Assign stream quota to Shard 0, Quota 5, TxId 281474976710660 Reserved: 5 of 25, Queued: 0
2025-11-21T15:47:17.834444Z node 10 :READ_TABLE_API DEBUG: rpc_read_table.cpp:647: [10:7575205781575803895:2334] got stream part, size: 290, RU required: 128 rate limiter absent
2025-11-21T15:47:17.834726Z node 10 :READ_TABLE_API DEBUG: rpc_read_table.cpp:563: [10:7575205781575803895:2334] Starting inactivity timer for 600.000000s with tag 3
2025-11-21T15:47:17.882626Z node 10 :READ_TABLE_API NOTICE: rpc_read_table.cpp:531: [10:7575205781575803895:2334] Finish grpc stream, status: 400000
2025-11-21T15:47:17.891289Z node 10 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:646: Got grpc request# ReadTableRequest, traceId# 01kakhjcr31pdy1j3w0d5j2rdr, sdkBuildInfo# undef, state# AS_NOT_PERFORMED, database# undef, peer# ipv6:[::1]:43920, grpcInfo# grpc-c++/1.54.3 grpc-c/31.0.0 (linux; chttp2), timeout# undef
2025-11-21T15:47:17.925707Z node 10 :READ_TABLE_API DEBUG: rpc_read_table.cpp:267: [10:7575205781575803922:2336] Adding quota request to queue ShardId: 0, TxId: 281474976710662
2025-11-21T15:47:17.925742Z node 10 :READ_TABLE_API DEBUG: rpc_read_table.cpp:629: [10:7575205781575803922:2336] Assign stream quota to Shard 0, Quota 5, TxId 281474976710662 Reserved: 5 of 25, Queued: 0
2025-11-21T15:47:17.926326Z node 10 :READ_TABLE_API DEBUG: rpc_read_table.cpp:647: [10:7575205781575803922:2336] got stream part, size: 83, RU required: 128 rate limiter absent
2025-11-21T15:47:17.926618Z node 10 :READ_TABLE_API DEBUG: rpc_read_table.cpp:563: [10:7575205781575803922:2336] Starting inactivity timer for 600.000000s with tag 3
2025-11-21T15:47:17.932533Z node 10 :READ_TABLE_API NOTICE: rpc_read_table.cpp:531: [10:7575205781575803922:2336] Finish grpc stream, status: 400000
2025-11-21T15:47:17.951045Z node 10 :GRPC_SERVER DEBUG: grpc_request_proxy.cpp:646: Got grpc request# ReadTableRequest, traceId# 01kakhjcsy0w271cya9ys6r73q, sdkBuildInfo# undef, state# AS_NOT_PERFORMED, database# undef, peer# ipv6:[::1]:43920, grpcInfo# grpc-c++/1.54.3 grpc-c/31.0.0 (linux; chttp2), timeout# undef
2025-11-21T15:47:17.983514Z node 10 :READ_TABLE_API DEBUG: rpc_read_table.cpp:267: [10:7575205781575803944:2338] Adding quota request to queue ShardId: 0, TxId: 281474976710664
2025-11-21T15:47:17.983549Z node 10 :READ_TABLE_API DEBUG: rpc_read_table.cpp:629: [10:7575205781575803944:2338] Assign stream quota to Shard 0, Quota 5, TxId 281474976710664 Reserved: 5 of 25, Queued: 0
2025-11-21T15:47:17.984476Z node 10 :READ_TABLE_API DEBUG: rpc_read_table.cpp:647: [10:7575205781575803944:2338] got stream part, size: 244, RU required: 128 rate limiter absent
2025-11-21T15:47:17.984773Z node 10 :READ_TABLE_API DEBUG: rpc_read_table.cpp:563: [10:7575205781575803944:2338] Starting inactivity timer for 600.000000s with tag 3
2025-11-21T15:47:17.989595Z node 10 :READ_TABLE_API NOTICE: rpc_read_table.cpp:531: [10:7575205781575803944:2338] Finish grpc stream, status: 400000
