2025-11-28T14:07:28.013059Z node 10 :BS_NODE WARN: {NWDC01@distconf.cpp:397} StateFunc too long Type# 268639248 Duration# 0.005676s
2025-11-28T14:07:28.102365Z node 10 :METADATA_PROVIDER WARN: log.cpp:841: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[10:7577777652204021801:2087];send_to=[0:7307199536658146131:7762515];
2025-11-28T14:07:28.102434Z 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;
test_client.cpp: SetPath # /home/runner/.ya/build/build_root/dzqe/002729/r3tmp/tmpBH0b9x/pdisk_1.dat
2025-11-28T14:07:28.178530Z 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-28T14:07:28.361324Z node 10 :IMPORT WARN: schemeshard_import.cpp:307: Table profiles were not loaded
2025-11-28T14:07:28.383111Z node 10 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(10, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-28T14:07:28.383218Z node 10 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(10, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-28T14:07:28.389396Z node 10 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(10, (0,0,0,0)) VolatileState: Connecting -> Connected
TServer::EnableGrpc on GrpcPort 15850, node 10
2025-11-28T14:07:28.464813Z 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-28T14:07:28.513653Z node 10 :NET_CLASSIFIER WARN: net_classifier.cpp:190: distributable config is empty, broken or outdated, will use file: (empty maybe)
2025-11-28T14:07:28.513687Z node 10 :NET_CLASSIFIER WARN: net_classifier.cpp:196: will try to initialize from file: (empty maybe)
2025-11-28T14:07:28.513696Z node 10 :NET_CLASSIFIER WARN: net_classifier.cpp:204: failed to initialize from file: (empty maybe)
2025-11-28T14:07:28.513925Z node 10 :NET_CLASSIFIER ERROR: net_classifier.cpp:228: got bad distributable configuration
TClient is connected to server localhost:21633
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-28T14:07:28.773268Z 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...
TClient is connected to server localhost:21633
2025-11-28T14:07:29.151640Z node 10 :TX_CONVEYOR ERROR: log.cpp:841: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-11-28T14:07:29.244060Z node 10 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateSubDomain, 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_subdomain.cpp:259)
waiting...
2025-11-28T14:07:29.282020Z node 10 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 281474976710659: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-28T14:07:29.800301Z node 12 :METADATA_PROVIDER WARN: log.cpp:841: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[12:7577777655667728033:2149];send_to=[0:7307199536658146131:7762515];
2025-11-28T14:07:29.800676Z node 12 :METADATA_PROVIDER ERROR: log.cpp:841: fline=accessor_snapshot_base.cpp:71;action=cannot detect path existence;path=//Root/ydb_tenant_0/.metadata/initialization/migrations;error=scheme_cache_undelivered_message;
2025-11-28T14:07:29.807293Z node 10 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(12, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-28T14:07:29.807380Z node 10 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(12, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-28T14:07:29.817842Z node 10 :HIVE WARN: hive_impl.cpp:811: HIVE#72057594037968897 Handle TEvInterconnect::TEvNodeConnected, NodeId 12 Cookie 12
2025-11-28T14:07:29.825318Z node 10 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(12, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-11-28T14:07:29.929042Z node 12 :KQP_PROXY WARN: kqp_finalize_script_service.cpp:135: [ScriptExecutions] [TKqpFinalizeScriptService] Failed to check script execution tables existence, scheme status: PathErrorUnknown, path: Root/ydb_tenant_0/.metadata/script_executions
2025-11-28T14:07:30.212364Z node 10 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateSubDomain, opId: 281474976710660: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_subdomain.cpp:259)
waiting...
2025-11-28T14:07:30.296519Z node 10 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpAlterSubDomain, opId: 281474976710661: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-28T14:07:30.805470Z node 12 :TX_CONVEYOR ERROR: log.cpp:841: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-11-28T14:07:30.808848Z node 11 :METADATA_PROVIDER WARN: log.cpp:841: fline=table_exists.cpp:54;actor=TTableExistsActor;event=undelivered;self_id=[11:7577777661300103548:2150];send_to=[0:7307199536658146131:7762515];
2025-11-28T14:07:30.809305Z node 11 :METADATA_PROVIDER ERROR: log.cpp:841: fline=accessor_snapshot_base.cpp:71;action=cannot detect path existence;path=//Root/ydb_tenant_1/.metadata/initialization/migrations;error=scheme_cache_undelivered_message;
2025-11-28T14:07:30.963174Z node 11 :KQP_PROXY WARN: kqp_finalize_script_service.cpp:135: [ScriptExecutions] [TKqpFinalizeScriptService] Failed to check script execution tables existence, scheme status: PathErrorUnknown, path: Root/ydb_tenant_1/.metadata/script_executions
2025-11-28T14:07:30.961858Z node 10 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(11, (0,0,0,0)) VolatileState: Unknown -> Disconnected
2025-11-28T14:07:30.962031Z node 10 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(11, (0,0,0,0)) VolatileState: Disconnected -> Connecting
2025-11-28T14:07:30.976415Z node 10 :HIVE WARN: hive_impl.cpp:811: HIVE#72057594037968897 Handle TEvInterconnect::TEvNodeConnected, NodeId 11 Cookie 11
2025-11-28T14:07:30.981416Z node 10 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(11, (0,0,0,0)) VolatileState: Connecting -> Connected
2025-11-28T14:07:31.824441Z node 11 :TX_CONVEYOR ERROR: log.cpp:841: fline=service.h:53;problem=unexpected event for task executor;ev_type=NActors::TEvents::TEvWakeup;
2025-11-28T14:07:33.102967Z node 10 :METADATA_PROVIDER ERROR: log.cpp:841: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[10:7577777652204021801:2087];send_to=[0:7307199536658146131:7762515];
2025-11-28T14:07:33.103055Z 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-28T14:07:33.524578Z node 10 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710662: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-28T14:07:33.678748Z node 10 :FLAT_TX_SCHEMESHARD WARN: schemeshard__operation.cpp:183: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976710663: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-28T14:07:33.947293Z node 10 :KQP_EXECUTER ERROR: kqp_planner.cpp:124: TxId: 281474976710664. Ctx: { TraceId: 01kb5cmsx98cc0cb3xcfy1t46x, Database: , SessionId: ydb://session/3?node_id=10&id=OGU4OWE4MDItYTdjYTJhNTktMmZmZmE3ZmEtODY3NzEwOGE=, PoolId: , DatabaseId: /Root, IsStreamingQuery: 0}. Database not set, use /Root
2025-11-28T14:07:34.230843Z node 10 :KQP_EXECUTER ERROR: kqp_planner.cpp:124: TxId: 281474976710665. Ctx: { TraceId: 01kb5cmt49c4j2ctfa5c9560zm, Database: , SessionId: ydb://session/3?node_id=10&id=OGU4OWE4MDItYTdjYTJhNTktMmZmZmE3ZmEtODY3NzEwOGE=, PoolId: , DatabaseId: /Root, IsStreamingQuery: 0}. Database not set, use /Root
2025-11-28T14:07:34.403404Z node 10 :KQP_EXECUTER ERROR: kqp_planner.cpp:124: TxId: 281474976710666. Ctx: { TraceId: 01kb5cmtbn8af9pw6t00g76wz0, Database: , SessionId: ydb://session/3?node_id=10&id=OGU4OWE4MDItYTdjYTJhNTktMmZmZmE3ZmEtODY3NzEwOGE=, PoolId: , DatabaseId: /Root, IsStreamingQuery: 0}. Database not set, use /Root
2025-11-28T14:07:34.801150Z node 12 :METADATA_PROVIDER ERROR: log.cpp:841: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[12:7577777655667728033:2149];send_to=[0:7307199536658146131:7762515];
2025-11-28T14:07:34.801235Z node 12 :METADATA_PROVIDER ERROR: log.cpp:841: fline=accessor_snapshot_base.cpp:71;action=cannot detect path existence;path=//Root/ydb_tenant_0/.metadata/initialization/migrations;error=timeout;
2025-11-28T14:07:35.255703Z node 10 :KQP_EXECUTER ERROR: kqp_planner.cpp:124: TxId: 281474976710667. Ctx: { TraceId: 01kb5cmtbn8af9pw6t00g76wz0, Database: , SessionId: ydb://session/3?node_id=10&id=OGU4OWE4MDItYTdjYTJhNTktMmZmZmE3ZmEtODY3NzEwOGE=, PoolId: , DatabaseId: /Root, IsStreamingQuery: 0}. Database not set, use /Root
2025-11-28T14:07:35.266303Z node 10 :KQP_EXECUTER ERROR: kqp_data_executer.cpp:795: ActorId: [10:7577777682268795145:2344] TxId: 281474976710667. Ctx: { TraceId: 01kb5cmtbn8af9pw6t00g76wz0, Database: , SessionId: ydb://session/3?node_id=10&id=OGU4OWE4MDItYTdjYTJhNTktMmZmZmE3ZmEtODY3NzEwOGE=, PoolId: , DatabaseId: /Root, IsStreamingQuery: 0}. Handle TEvProposeTransactionResult: unable to select coordinator. Tx canceled, actorId: [10:7577777682268795145:2344], previously selected coordinator: 72075186224037888, coordinator selected at propose result: 72075186224037890
2025-11-28T14:07:35.266723Z node 10 :KQP_SESSION WARN: kqp_session_actor.cpp:2874: SessionId: ydb://session/3?node_id=10&id=OGU4OWE4MDItYTdjYTJhNTktMmZmZmE3ZmEtODY3NzEwOGE=, ActorId: [10:7577777673678860233:2344], ActorState: ExecuteState, TraceId: 01kb5cmtbn8af9pw6t00g76wz0, Create QueryResponse for error on request, msg: , status: CANCELLED, issues: { message: "Unable to choose coordinator." issue_code: 200508 severity: 1 }
2025-11-28T14:07:35.267730Z node 10 :KQP_EXECUTER ERROR: kqp_planner.cpp:124: TxId: 281474976710668. Ctx: { TraceId: 01kb5cmtbn8af9pw6t00g76wz0, Database: , SessionId: ydb://session/3?node_id=10&id=OGU4OWE4MDItYTdjYTJhNTktMmZmZmE3ZmEtODY3NzEwOGE=, PoolId: , DatabaseId: /Root, IsStreamingQuery: 0}. Database not set, use /Root
2025-11-28T14:07:35.283923Z node 10 :HIVE WARN: tx__status.cpp:58: HIVE#72057594037968897 THive::TTxStatus(status=2 node=Connected) - killing node 12
2025-11-28T14:07:35.284486Z node 10 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(12, (0,0,0,0)) VolatileState: Connected -> Disconnected
2025-11-28T14:07:35.284612Z node 10 :HIVE WARN: tx__status.cpp:58: HIVE#72057594037968897 THive::TTxStatus(status=2 node=Connected) - killing node 11
2025-11-28T14:07:35.284960Z node 10 :HIVE WARN: node_info.cpp:25: HIVE#72057594037968897 Node(11, (0,0,0,0)) VolatileState: Connected -> Disconnected
2025-11-28T14:07:35.808953Z node 11 :METADATA_PROVIDER ERROR: log.cpp:841: fline=table_exists.cpp:59;actor=TTableExistsActor;event=timeout;self_id=[11:7577777661300103548:2150];send_to=[0:7307199536658146131:7762515];
2025-11-28T14:07:35.809040Z node 11 :METADATA_PROVIDER ERROR: log.cpp:841: fline=accessor_snapshot_base.cpp:71;action=cannot detect path existence;path=//Root/ydb_tenant_1/.metadata/initialization/migrations;error=timeout;
