2025-12-09T03:42:54.084332Z :GRPC_SERVER NOTICE: grpc_request_proxy.cpp:380: Grpc request proxy started, nodeid# 2, serve as static node
2025-12-09T03:42:54.084410Z :GRPC_SERVER CRIT: grpc_request_proxy.cpp:440: Failed to deliver subscription request to config dispatcher
2025-12-09T03:42:54.084416Z :GRPC_SERVER NOTICE: grpc_request_proxy.cpp:380: Grpc request proxy started, nodeid# 2, serve as static node
2025-12-09T03:42:54.084435Z :GRPC_SERVER CRIT: grpc_request_proxy.cpp:440: Failed to deliver subscription request to config dispatcher
2025-12-09T03:42:54.084810Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:214: Bootstrap
2025-12-09T03:42:54.084813Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:217: Create sdk ydb connection
2025-12-09T03:42:54.085273Z :FQ_QUOTA_SERVICE INFO: quota_manager.cpp:196: STARTED
2025-12-09T03:42:54.085283Z :FQ_QUOTA_PROXY INFO: quota_proxy.cpp:90: STARTED
2025-12-09T03:42:54.085318Z :FQ_LOG_UPDATER DEBUG: log.cpp:93: Updated YQL logs priority: 8
2025-12-09T03:42:54.085320Z :FQ_LOG_UPDATER CRIT: log.cpp:55: Failed to deliver subscription request to config dispatcher.
2025-12-09T03:42:54.085342Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:544: RowDispatcher: Successfully bootstrapped row dispatcher, id [2:7581698642336289805:2063], tenant /compute
2025-12-09T03:42:54.085350Z :YQ_RATE_LIMITER INFO: quoter_service.cpp:124: Bootstraping with config: { Enabled: true DataPlaneEnabled: true Database { Endpoint: "localhost:31363" Database: "local" TablePrefix: "RateLimiter_97c9901c-12d5-4d31-adc4-4a88f7d60d8c" } Limiters { CoordinationNodePath: "rate_limiter" } }
2025-12-09T03:42:54.085355Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [2:7581698642336289805:2063]
2025-12-09T03:42:54.085357Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:329: Coordinator: Add new row dispatcher to map (state 1)
2025-12-09T03:42:54.085441Z :YQL_NODES_MANAGER INFO: nodes_manager.cpp:88: Bootstrap, InstanceId: b48971f5-419b0d00-b44428b8-724f0ceb
2025-12-09T03:42:54.085443Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:310: TNodesManagerActor::ResolveSelfAddress
2025-12-09T03:42:54.085457Z :YQ_TEST_CONNECTION DEBUG: test_connection.cpp:142: Starting yandex query test connection. Actor id: [2:7581698642336289810:2068]
2025-12-09T03:42:54.085486Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d1, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:42:54.085498Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:293: Coordinator: Successfully bootstrapped coordinator, id [2:7581698642336289850:2092], NodesManagerId [0:4705493345362661702:78], rebalancing timeout 5.000000s
2025-12-09T03:42:54.085527Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:232: TLeaderElection [2:7581698642336289851:2093] Successfully bootstrapped, local coordinator id [2:7581698642336289850:2092], tenant id compute, local mode 0, coordination node path local/compute, endpoint localhost:31363
2025-12-09T03:42:54.086178Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:239: Successfully bootstrapped TStorageProxy [2:7581698642336289804:2062] with connection to localhost:31363:local
2025-12-09T03:42:54.086188Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:637: RowDispatcher: TEvCoordinatorChangesSubscribe from [2:7581698642336289850:2092]
2025-12-09T03:42:54.086862Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-12-09T03:42:54.087121Z :MEMORY_PROFILER NOTICE: monitor.cpp:332: Bootstrapped
2025-12-09T03:42:54.088214Z :SCHEME_BOARD_SUBSCRIBER NOTICE: subscriber.cpp:849: [main][2:7581698642336289825:2078][/compute] Set up state: owner# [2:7581698642336289784:2052], state# { Deleted: 1 Strong: 0 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-12-09T03:42:54.088243Z :SCHEME_BOARD_SUBSCRIBER NOTICE: subscriber.cpp:849: [main][2:7581698642336289824:2077][/Root] Set up state: owner# [2:7581698642336289784:2052], state# { Deleted: 1 Strong: 0 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-12-09T03:42:54.088250Z :SCHEME_BOARD_SUBSCRIBER NOTICE: subscriber.cpp:849: [main][2:7581698642336289826:2079][/Root] Set up state: owner# [2:7581698642336289785:2053], state# { Deleted: 1 Strong: 0 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-12-09T03:42:54.088258Z :GRPC_SERVER WARN: grpc_request_proxy.cpp:583: SchemeBoardDelete /compute Strong=0
2025-12-09T03:42:54.088261Z :GRPC_SERVER WARN: grpc_request_proxy.cpp:583: SchemeBoardDelete /Root Strong=0
2025-12-09T03:42:54.088261Z :SCHEME_BOARD_SUBSCRIBER NOTICE: subscriber.cpp:849: [main][2:7581698642336289827:2080][/compute] Set up state: owner# [2:7581698642336289785:2053], state# { Deleted: 1 Strong: 0 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-12-09T03:42:54.088262Z :GRPC_SERVER WARN: grpc_request_proxy.cpp:583: SchemeBoardDelete /Root Strong=0
2025-12-09T03:42:54.088265Z :GRPC_SERVER WARN: grpc_request_proxy.cpp:583: SchemeBoardDelete /compute Strong=0
2025-12-09T03:42:54.089329Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:71: Run create coordination node "local/compute" actor
2025-12-09T03:42:54.089346Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:113: Call create coordination node "local/compute"
2025-12-09T03:42:54.089348Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:411: Call create coordination node "local/compute"
2025-12-09T03:42:54.111516Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:42:54.111531Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:42:54.111554Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:389: Send NodeInfo with size: 1 to DynamicNameserver
2025-12-09T03:42:54.112215Z :INTERCONNECT WARN: interconnect_handshake.cpp:501: Handshake [2:7581698642336289914:2052] [node 1] ICH09 Neither CompatibilityInfo nor VersionTag of the peer can be validated, accepting by default
2025-12-09T03:42:54.113590Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:155: Successfully created coordination node "local/compute"
2025-12-09T03:42:54.113609Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:122: Reply for create coordination node "local/compute": { <main>: Error: Check failed: path: '/local/compute', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 19], type: EPathTypeKesus, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_kesus.cpp:339 }
2025-12-09T03:42:54.113624Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:345: TLeaderElection [2:7581698642336289851:2093] Coordination node successfully created
2025-12-09T03:42:54.113627Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:323: TLeaderElection [2:7581698642336289851:2093] Start session
2025-12-09T03:42:54.115093Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:359: TLeaderElection [2:7581698642336289851:2093] Session successfully created
2025-12-09T03:42:54.117079Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:372: TLeaderElection [2:7581698642336289851:2093] Semaphore successfully created
2025-12-09T03:42:54.117090Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:304: TLeaderElection [2:7581698642336289851:2093] Try to acquire semaphore
2025-12-09T03:42:54.117240Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:420: TLeaderElection [2:7581698642336289851:2093] Describe semaphore
2025-12-09T03:42:54.118596Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:469: TLeaderElection [2:7581698642336289851:2093] Semaphore successfully described: coordinator id [1:7581698636826908017:2082] generation 6
2025-12-09T03:42:54.118604Z :FQ_ROW_DISPATCHER INFO: leader_election.cpp:471: TLeaderElection [2:7581698642336289851:2093] Send TEvCoordinatorChanged to [2:7581698642336289805:2063], new coordinator id [1:7581698636826908017:2082], previous coordinator id [0:0:0]
2025-12-09T03:42:54.118623Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:569: RowDispatcher: Coordinator changed, old leader (empty maybe), new [1:7581698636826908017:2082] generation 6
2025-12-09T03:42:54.118647Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:440: Coordinator: New leader [1:7581698636826908017:2082], SelfId [2:7581698642336289850:2092]
2025-12-09T03:42:54.119008Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-09T03:42:55.063416Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d2, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:42:55.064740Z :FQ_QUOTA_SERVICE DEBUG: quota_manager.cpp:230: IC Peers[1]: [1]
2025-12-09T03:42:55.068078Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:42:55.068090Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:42:56.063833Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7581698636826908017:2082]
2025-12-09T03:42:56.063856Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d3, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:42:56.063859Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-09T03:42:56.064227Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-09T03:42:56.068170Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:42:56.068183Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:42:57.064305Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d4, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:42:57.068051Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:42:57.068067Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:42:58.064713Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d5, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:42:58.064719Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7581698636826908017:2082]
2025-12-09T03:42:58.064746Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-09T03:42:58.065093Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-09T03:42:58.068724Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:42:58.068743Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:42:59.063105Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-12-09T03:42:59.063112Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:665: Coordinator: Change global state to Started (by timeout)
2025-12-09T03:42:59.065168Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d6, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:42:59.068824Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:42:59.068838Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:42:59.071158Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:389: Send NodeInfo with size: 1 to DynamicNameserver
2025-12-09T03:43:00.065583Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7581698636826908017:2082]
2025-12-09T03:43:00.065591Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d7, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:00.065604Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-09T03:43:00.065933Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-09T03:43:00.069432Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:00.069447Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:43:01.066517Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d8, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:01.073834Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:01.073851Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:43:02.066511Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7581698636826908017:2082]
2025-12-09T03:43:02.066535Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-09T03:43:02.067455Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-09T03:43:02.067540Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d9, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:02.071203Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:02.071219Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:43:03.067988Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d10, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:03.071874Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:03.071885Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:43:04.063326Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:599: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-12-09T03:43:04.063351Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-12-09T03:43:04.063608Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:300: Received TNodesManagerActor::TEvGetNodesRequest
2025-12-09T03:43:04.063814Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:690: Coordinator: Updated node info, node count: 2
2025-12-09T03:43:04.067436Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7581698636826908017:2082]
2025-12-09T03:43:04.067459Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-09T03:43:04.067929Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-09T03:43:04.068419Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d11, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:04.078250Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:389: Send NodeInfo with size: 1 to DynamicNameserver
2025-12-09T03:43:04.078283Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:04.078286Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:43:05.068889Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d12, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:05.073459Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:05.073473Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:43:06.068339Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7581698636826908017:2082]
2025-12-09T03:43:06.068366Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-09T03:43:06.068809Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-09T03:43:06.069316Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d13, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:06.073464Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:06.073478Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:43:07.070208Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d14, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:07.075960Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:07.075969Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:43:08.069202Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7581698636826908017:2082]
2025-12-09T03:43:08.069224Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-09T03:43:08.069690Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-09T03:43:08.070217Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d15, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:08.075050Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:08.075063Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:43:09.063486Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-12-09T03:43:09.070699Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d16, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:09.076960Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:09.076960Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:389: Send NodeInfo with size: 1 to DynamicNameserver
2025-12-09T03:43:09.076974Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:43:10.070115Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7581698636826908017:2082]
2025-12-09T03:43:10.070143Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-09T03:43:10.070650Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-09T03:43:10.071297Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d17, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:10.088000Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:10.088018Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 1
2025-12-09T03:43:10.088031Z :FQ_PENDING_FETCHER DEBUG: pending_fetcher.cpp:361: NewTask: Scope: yandexcloud://my_folder Id: ptqudqgd5mgqaqg51ao4 UserId: root@builtin AuthToken: **** (B6C6F477)
2025-12-09T03:43:10.088216Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d18, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:10.088267Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:375: QueryId: ptqudqgd5mgqaqg51ao4 Start run actor. Compute state: RUNNING
2025-12-09T03:43:10.088269Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:469: QueryId: ptqudqgd5mgqaqg51ao4 FillConnections
2025-12-09T03:43:10.088302Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:2333: QueryId: ptqudqgd5mgqaqg51ao4 Run actors params: { QueryId: ptqudqgd5mgqaqg51ao4 CloudId: mock_cloud UserId: root@builtin Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d17 PreviousQueryRevision: 2 Connections: 1 Bindings: 0 AccountIdSignatures: 0 QueryType: STREAMING ExecuteMode: RUN ResultId: ptrudqgd51pm3bkcndhv StateLoadMode: FROM_LAST_CHECKPOINT StreamingDisposition: { from_last_checkpoint { } } Status: RUNNING DqGraphs: 1 DqGraphIndex: 0 Resource.TopicConsumers: 1 }
2025-12-09T03:43:10.088352Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:911: QueryId: ptqudqgd5mgqaqg51ao4 Overall dq tasks: 1
2025-12-09T03:43:10.088533Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1598: QueryId: ptqudqgd5mgqaqg51ao4 ResultWriter was NOT CREATED since ResultType is empty
2025-12-09T03:43:10.088613Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudqgd5mgqaqg51ao4 2025-12-09 03:43:10.088 DEBUG ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] task_controller_impl.h:86: _RowsLimitPerWrite = 0
2025-12-09T03:43:10.088650Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1652: QueryId: ptqudqgd5mgqaqg51ao4 Executer: [2:7581698711055766740:2205], Controller: [2:7581698711055766742:2207], ResultIdActor: [2:7581698711055766740:2205]
2025-12-09T03:43:10.088685Z :FQ_PINGER TRACE: pinger.cpp:171: QueryId: ptqudqgd5mgqaqg51ao4, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d17 Start Pinger
2025-12-09T03:43:10.088852Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudqgd5mgqaqg51ao4, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d17 Forward ping request: { resources { rate_limiter: READY compilation: READY topic_consumers_state: READY rate_limiter_path: "local/RateLimiter_97c9901c-12d5-4d31-adc4-4a88f7d60d8c/rate_limiter" topic_consumers { database: "local" topic_path: "error_if_no_states_input" consumer_name: "ptqudqgd5mgqaqg51ao4" cluster_endpoint: "localhost:31363" token_name: "cluster:default_myyds" add_bearer_to_token: true } } }
2025-12-09T03:43:10.088856Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudqgd5mgqaqg51ao4, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d17 Forward request Private::PingTask
2025-12-09T03:43:10.088902Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudqgd5mgqaqg51ao4 2025-12-09 03:43:10.088 DEBUG ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] executer_actor.cpp:140: {ptqudqgd5mgqaqg51ao4} TDqExecuter::OnGraph
2025-12-09T03:43:10.088915Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudqgd5mgqaqg51ao4 2025-12-09 03:43:10.088 INFO  ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] executer_actor.cpp:157: {ptqudqgd5mgqaqg51ao4} Trying to allocate 1 workers [EnableComputeActor=1]
2025-12-09T03:43:10.089884Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudqgd5mgqaqg51ao4 2025-12-09 03:43:10.089 DEBUG ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] executer_actor.cpp:247: {ptqudqgd5mgqaqg51ao4} Dq timeouts are set to: 0.000000s (global), 600.000000s (workers allocation fail), 30.000000s (workers allocation warn) 
2025-12-09T03:43:10.090729Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:125: TEvAllocateWorkersResponse Nodes {
  ResourceId: 4294967298
  Worker {
    NodeId: 2
    Guid: "b48971f5-419b0d00-b44428b8-724f0ceb,ghrun-syjwtgwtdu"
  }
}
2025-12-09T03:43:10.095151Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:10.095166Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:43:10.104679Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudqgd5mgqaqg51ao4, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d17 Ping response success: { expired_at { seconds: 1765251810 nanos: 97000000 } }
2025-12-09T03:43:10.104716Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudqgd5mgqaqg51ao4 Forward ping response. Success: 1. Cookie: 0
2025-12-09T03:43:10.128314Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:144: SelfId: [2:7581698711055766744:2209], TxId: ptqudqgd5mgqaqg51ao4, task: 1. Ctx: {}. Start compute actor [2:7581698711055766744:2209], task: 1
2025-12-09T03:43:10.128367Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:114: SelfId: [2:7581698711055766744:2209], TxId: ptqudqgd5mgqaqg51ao4, task: 1. Ctx: {}. Use CPU quota: 1. Rate limiter resource: { "local/RateLimiter_97c9901c-12d5-4d31-adc4-4a88f7d60d8c/rate_limiter", "mock_cloud/my_folder/ptqudqgd5mgqaqg51ao4" }
2025-12-09T03:43:10.128381Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudqgd5mgqaqg51ao4 2025-12-09 03:43:10.128 DEBUG ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] executer_actor.cpp:358: {ptqudqgd5mgqaqg51ao4} TDqExecuter::TEvAllocateWorkersResponse
2025-12-09T03:43:10.128399Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudqgd5mgqaqg51ao4 2025-12-09 03:43:10.128 DEBUG ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] executer_actor.cpp:384: {ptqudqgd5mgqaqg51ao4} Allocated resource 4294967298
2025-12-09T03:43:10.128442Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudqgd5mgqaqg51ao4 2025-12-09 03:43:10.128 DEBUG ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] executer_actor.cpp:401: {ptqudqgd5mgqaqg51ao4} WorkerInfo: Id:b48971f5-419b0d00-b44428b8-724f0ceb,ghrun-syjwtgwtdu,NodeId:2,StageId:200275
2025-12-09T03:43:10.128457Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudqgd5mgqaqg51ao4 2025-12-09 03:43:10.128 DEBUG ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] executer_actor.cpp:402: {ptqudqgd5mgqaqg51ao4} TaskInfo: 0/1
2025-12-09T03:43:10.128465Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudqgd5mgqaqg51ao4 2025-12-09 03:43:10.128 DEBUG ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] executer_actor.cpp:404: {ptqudqgd5mgqaqg51ao4}  ObjectId: 2ad8a0198ac871ab3cd73b3e9d43a8d7c87aa707, dq_vanilla_job.lite, 
2025-12-09T03:43:10.128484Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudqgd5mgqaqg51ao4 2025-12-09 03:43:10.128 INFO  ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] executer_actor.cpp:415: {ptqudqgd5mgqaqg51ao4} 1 workers allocated
2025-12-09T03:43:10.128554Z :YQL_PROXY TRACE: log.cpp:64: SessionId:  2025-12-09 03:43:10.128 TRACE ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] task_controller_impl.h:271:  [2:7581698711055766742:2207] ExportStats Summary
2025-12-09T03:43:10.128579Z :YQL_PROXY DEBUG: log.cpp:64: SessionId:  2025-12-09 03:43:10.128 DEBUG ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] task_controller_impl.h:526: Ready State: [2:7581698711055766742:2207]
2025-12-09T03:43:10.128591Z :YQL_PROXY DEBUG: log.cpp:64: SessionId:  2025-12-09 03:43:10.128 DEBUG ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] task_controller_impl.h:537: Forward: [2:7581698711055766742:2207] to [2:7581698711055766741:2206]
2025-12-09T03:43:10.128616Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:70: [ptqudqgd5mgqaqg51ao4-0.2] TEvReadyState, streaming disposition { from_last_checkpoint { } }, state load mode FROM_LAST_CHECKPOINT, checkpointing period 1.000000s
2025-12-09T03:43:10.128624Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:104: [ptqudqgd5mgqaqg51ao4-0.2] AllActors count: 1, ActorsToTrigger count: 1, ActorsToNotify count: 1, ActorsToWaitFor count: 1
2025-12-09T03:43:10.128626Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:114: [ptqudqgd5mgqaqg51ao4-0.2] Send TEvRegisterCoordinatorRequest
2025-12-09T03:43:10.128632Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:261: [ptqudqgd5mgqaqg51ao4-0.2] Got TEvRegisterCoordinatorRequest
2025-12-09T03:43:10.128633Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:243: StartInitialization, EnableSecureScriptExecutions: 0
2025-12-09T03:43:10.129297Z :STREAMS_STORAGE_SERVICE NOTICE: storage_proxy.cpp:585: Add to delayed
2025-12-09T03:43:10.142455Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:557: Checkpoint storage and state storage were successfully initted
2025-12-09T03:43:10.142468Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:261: [ptqudqgd5mgqaqg51ao4-0.2] Got TEvRegisterCoordinatorRequest
2025-12-09T03:43:10.166592Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:279: [ptqudqgd5mgqaqg51ao4-0.2] Graph registered
2025-12-09T03:43:10.166609Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:281: [ptqudqgd5mgqaqg51ao4-0.2] Send TEvRegisterCoordinatorResponse
2025-12-09T03:43:10.166670Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:131: [ptqudqgd5mgqaqg51ao4-0.2] Got TEvRegisterCoordinatorResponse; issues: 
2025-12-09T03:43:10.166680Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:140: [ptqudqgd5mgqaqg51ao4-0.2] Successfully registered in storage
2025-12-09T03:43:10.166683Z :STREAMS_CHECKPOINT_COORDINATOR INFO: checkpoint_coordinator.cpp:141: [ptqudqgd5mgqaqg51ao4-0.2] Send TEvNewCheckpointCoordinator to 1 actor(s)
2025-12-09T03:43:10.166692Z :STREAMS_CHECKPOINT_COORDINATOR INFO: checkpoint_coordinator.cpp:149: [ptqudqgd5mgqaqg51ao4-0.2] Send TEvGetCheckpointsMetadataRequest; state load mode: FROM_LAST_CHECKPOINT; load graph: 0
2025-12-09T03:43:10.166728Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:434: [ptqudqgd5mgqaqg51ao4-0] Got TEvGetCheckpointsMetadataRequest
2025-12-09T03:43:10.177172Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:197: [] Task: 1. Got TEvNewCheckpointCoordinator event: generation 2, actorId: [2:7581698711055766741:2206]
2025-12-09T03:43:10.177185Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:208: [] Task: 1. Assign checkpoint coordinator (generation = 2)
2025-12-09T03:43:10.177916Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1360: SelfId: [2:7581698711055766744:2209], TxId: ptqudqgd5mgqaqg51ao4, task: 1. Ctx: {}. Create source for input 0 { Source { Type: "PqSource" Settings { type_url: "type.googleapis.com/NYql.NPq.NProto.TDqPqTopicSource" value: "\n\030error_if_no_states_input\022\024ptqudqgd5mgqaqg51ao4\032\017localhost:31363\"\027\n\025cluster:default_myyds*\005local0\002@\001b\004Dataj\025[\"DataType\";\"String\"]\222\001\024ptcudqgd5mtl6h4afmn3\232\001\003raw\242\001/[\"StructType\";[[\"Data\";[\"DataType\";\"String\"]]]]\262\001\002\022\000\272\001\026\n\010cloud_id\022\nmock_cloud\272\001 \n\005scope\022\027yandexcloud://my_folder" } WatermarksMode: WATERMARKS_MODE_DISABLED } }
2025-12-09T03:43:10.178242Z :KQP_COMPUTE DEBUG: dq_pq_read_actor_base.cpp:153: SelfId: [0:0:0], TxId: ptqudqgd5mgqaqg51ao4, task: 1. PQ source. SessionId: empty Watermarks enabled: 0 granularity: 0.000000s late arrival delay: 0.000000s idle: 0 idle timeout: 0.000000s
2025-12-09T03:43:10.178266Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1447: SelfId: [2:7581698711055766744:2209], TxId: ptqudqgd5mgqaqg51ao4, task: 1. Ctx: {}. Create sink for output 0 { Sink { Type: "PqSink" Settings { type_url: "type.googleapis.com/NYql.NPq.NProto.TDqPqTopicSink" value: "\n\031error_if_no_states_output\022\017localhost:31363\032\027\n\025cluster:default_myyds\"\005local0\0018\002" } } }
2025-12-09T03:43:10.178340Z :YQL_PROXY TRACE: log.cpp:64: SessionId:  2025-12-09 03:43:10.178 TRACE ydbd(pid=1627699, tid=0x00007FC3574D6640) [DQ] task_controller_impl.h:160: [2:7581698711055766742:2207] EvState TaskId: 1 State: 2 PingCookie: 0 StatusCode: UNSPECIFIED
2025-12-09T03:43:10.178356Z :YQL_PROXY TRACE: log.cpp:64: SessionId:  2025-12-09 03:43:10.178 TRACE ydbd(pid=1627699, tid=0x00007FC3574D6640) [DQ] task_controller_impl.h:201:  [2:7581698711055766742:2207] Executing TaskId: 1
2025-12-09T03:43:10.178376Z :YQL_PROXY DEBUG: log.cpp:64: SessionId:  2025-12-09 03:43:10.178 DEBUG ydbd(pid=1627699, tid=0x00007FC3574D6640) [DQ] task_controller_impl.h:561: Update channels
2025-12-09T03:43:10.178805Z :YQL_PROXY TRACE: log.cpp:64: SessionId:  2025-12-09 03:43:10.178 TRACE ydbd(pid=1627699, tid=0x00007FC3574D6640) [DQ] task_controller_impl.h:577: 1 
2025-12-09T03:43:10.178825Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1064: SelfId: [2:7581698711055766744:2209], TxId: ptqudqgd5mgqaqg51ao4, task: 1. Ctx: {}. Received channels info: 
2025-12-09T03:43:10.222410Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:451: [ptqudqgd5mgqaqg51ao4-0] Send TEvGetCheckpointsMetadataResponse
2025-12-09T03:43:10.222504Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:186: [ptqudqgd5mgqaqg51ao4-0.2] Got TEvGetCheckpointsMetadataResponse
2025-12-09T03:43:10.222514Z :STREAMS_CHECKPOINT_COORDINATOR INFO: checkpoint_coordinator.cpp:219: [ptqudqgd5mgqaqg51ao4-0.2] Will restore from checkpoint 1:2
2025-12-09T03:43:10.222756Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:265: [ptqudqgd5mgqaqg51ao4-0] Task: 1. [Checkpoint 1.2] TEvRestoreFromCheckpoint, StateLoadPlan = { StateType: STATE_TYPE_OWN }
2025-12-09T03:43:10.222786Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:508: [ptqudqgd5mgqaqg51ao4-0] [1:2] Got TEvGetTaskState: tasks {1}
2025-12-09T03:43:10.222792Z :STREAMS_STORAGE_SERVICE DEBUG: ydb_state_storage.cpp:519: [ptqudqgd5mgqaqg51ao4-0] [1:2] GetState, tasks: 1
2025-12-09T03:43:10.308239Z :STREAMS_STORAGE_SERVICE DEBUG: ydb_state_storage.cpp:654: [ptqudqgd5mgqaqg51ao4-0] [1:2] ListOfStates results:
2025-12-09T03:43:10.308390Z :STREAMS_STORAGE_SERVICE WARN: storage_proxy.cpp:525: [ptqudqgd5mgqaqg51ao4-0] [{ Id: 2 Generation: 1 }] Failed to get task state: tasks: {1}, issues: <main>: Error: Checkpoint is not found
2025-12-09T03:43:10.308399Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:527: [ptqudqgd5mgqaqg51ao4-0] [{ Id: 2 Generation: 1 }] Send TEvGetTaskStateResult: tasks: {1}
2025-12-09T03:43:10.308461Z :KQP_COMPUTE ERROR: dq_compute_actor_checkpoints.cpp:321: [ptqudqgd5mgqaqg51ao4-0] Task: 1. [Checkpoint 1.2] TEvGetTaskStateResult error: { <main>: Error: Checkpoint is not found }
2025-12-09T03:43:10.308490Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:297: [ptqudqgd5mgqaqg51ao4-0.2] [1:2] Got TEvRestoreFromCheckpointResult; taskId: 1, checkpoint: 1:2, status: STORAGE_ERROR, issues: { <main>: Error: Checkpoint is not found }
2025-12-09T03:43:10.308496Z :STREAMS_CHECKPOINT_COORDINATOR ERROR: checkpoint_coordinator.cpp:313: [ptqudqgd5mgqaqg51ao4-0.2] [1:2] Can't restore: STORAGE_ERROR, { <main>: Error: Checkpoint is not found }
2025-12-09T03:43:10.308573Z :YQL_PROXY DEBUG: log.cpp:64: SessionId:  2025-12-09 03:43:10.308 DEBUG ydbd(pid=1627699, tid=0x00007FC3574D6640) [DQ] task_controller_impl.h:130: AbortExecution from [0:0:0]:ABORTED { <main>: Error: Can't restore: STORAGE_ERROR, { <main>: Error: Checkpoint is not found } }
2025-12-09T03:43:10.308596Z :YQL_PROXY DEBUG: log.cpp:64: SessionId:  2025-12-09 03:43:10.308 DEBUG ydbd(pid=1627699, tid=0x00007FC3574D6640) [DQ] task_controller_impl.h:598: OnError { <main>: Error: Can't restore: STORAGE_ERROR, { <main>: Error: Checkpoint is not found } } ABORTED
2025-12-09T03:43:10.308663Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudqgd5mgqaqg51ao4 2025-12-09 03:43:10.308 DEBUG ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] executer_actor.cpp:304: {ptqudqgd5mgqaqg51ao4} OnFailure, status=4, issues size=1, sender=[2:7581698711055766742:2207]
2025-12-09T03:43:10.308696Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudqgd5mgqaqg51ao4 2025-12-09 03:43:10.308 DEBUG ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] executer_actor.cpp:315: {ptqudqgd5mgqaqg51ao4} Issues: <main>: Error: Can't restore: STORAGE_ERROR, { <main>: Error: Checkpoint is not found }

2025-12-09T03:43:10.308712Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudqgd5mgqaqg51ao4 2025-12-09 03:43:10.308 DEBUG ydbd(pid=1627699, tid=0x00007FC3584D8640) [DQ] executer_actor.cpp:284: {ptqudqgd5mgqaqg51ao4} Finish with status=4 issues=<main>: Error: Can't restore: STORAGE_ERROR, { <main>: Error: Checkpoint is not found }

2025-12-09T03:43:10.308767Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudqgd5mgqaqg51ao4 2025-12-09 03:43:10.308 DEBUG ydbd(pid=1627699, tid=0x00007FC3574D6640) [DQ] executer_actor.cpp:341: {ptqudqgd5mgqaqg51ao4} OnQueryResponse status=4 issuses_size=1
2025-12-09T03:43:10.308793Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1233: QueryId: ptqudqgd5mgqaqg51ao4 Query response ABORTED. Result set index: 0. Issues count: 1. Rows count: 0
2025-12-09T03:43:10.308889Z :FQ_RUN_ACTOR WARN: run_actor.cpp:1914: QueryId: ptqudqgd5mgqaqg51ao4 ResignQuery, status ABORTED
2025-12-09T03:43:10.308900Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1919: QueryId: ptqudqgd5mgqaqg51ao4 SendPingAndPassAway, FinalQueryStatus COMPUTE_STATUS_UNSPECIFIED
2025-12-09T03:43:10.308915Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:536: QueryId: ptqudqgd5mgqaqg51ao4 PassAway
2025-12-09T03:43:10.309001Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:657: [ptqudqgd5mgqaqg51ao4-0.2] PassAway
2025-12-09T03:43:10.309064Z :KQP_COMPUTE ERROR: dq_compute_actor_impl.h:1205: SelfId: [2:7581698711055766744:2209], TxId: ptqudqgd5mgqaqg51ao4, task: 1. Ctx: {}. Handle abort execution event from: [2:7581698642336289806:2064], status: UNAVAILABLE, reason: { <main>: Error: Aborted by LWM }
2025-12-09T03:43:10.309098Z :KQP_COMPUTE DEBUG: dq_compute_actor_channels.cpp:494: TxId: ptqudqgd5mgqaqg51ao4, task: 1. pass away
2025-12-09T03:43:10.309098Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudqgd5mgqaqg51ao4, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d17 Forward ping request: { result_id { value: "ptrudqgd51pm3bkcndhv" } statistics: "{\"Graph=0\":{\"Actor\":{\"ActorCreateTimeUs\":{\"sum\":\"37ms\",\"count\":1,\"avg\":\"37ms\",\"max\":\"37ms\",\"min\":\"37ms\"}},\"AllocateWorkersUs\":{\"sum\":\"38ms\",\"count\":1,\"avg\":\"38ms\",\"max\":\"38ms\",\"min\":\"38ms\"},\"ExecutionTimeUs\":{\"sum\":\"0.18s\",\"count\":1,\"avg\":\"0.18s\",\"max\":\"0.18s\",\"min\":\"0.18s\"},\"TaskRunner\":{\"Stage=200275\":{\"CpuTimeUs\":{\"sum\":\"0.00s\",\"count\":1,\"avg\":\"0.00s\",\"max\":\"0.00s\",\"min\":\"0.00s\"},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"CpuTimeUs\":{\"sum\":\"0.00s\",\"count\":1,\"avg\":\"0.00s\",\"max\":\"0.00s\",\"min\":\"0.00s\"},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}},\"UniqueWorkers\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}}" resign_query: true transient_issues { message: "Can\'t restore: STORAGE_ERROR, { <main>: Error: Checkpoint is not found }" severity: 1 } status_code: ABORTED resources { rate_limiter: READY compilation: READY topic_consumers_state: READY rate_limiter_path: "local/RateLimiter_97c9901c-12d5-4d31-adc4-4a88f7d60d8c/rate_limiter" topic_consumers { database: "local" topic_path: "error_if_no_states_input" consumer_name: "ptqudqgd5mgqaqg51ao4" cluster_endpoint: "localhost:31363" token_name: "cluster:default_myyds" add_bearer_to_token: true } } }
2025-12-09T03:43:10.309101Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudqgd5mgqaqg51ao4, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d17 Forward request Private::PingTask
2025-12-09T03:43:10.392673Z :FQ_PINGER ERROR: pinger.cpp:365: QueryId: ptqudqgd5mgqaqg51ao4, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d17 Ping response error: Query ownership time is over: expired_at=2025-12-09T03:43:10.315000Z < now=2025-12-09T03:43:10.392619Z. Retried 0 times during 0.083973s
2025-12-09T03:43:10.392699Z :FQ_PINGER DEBUG: pinger.cpp:379: QueryId: ptqudqgd5mgqaqg51ao4, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d17 Query finished
2025-12-09T03:43:10.392702Z :FQ_PINGER TRACE: pinger.cpp:187: QueryId: ptqudqgd5mgqaqg51ao4, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d17 Stop Pinger
2025-12-09T03:43:11.071597Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d19, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:11.075682Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:11.075698Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-09T03:43:12.070998Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7581698636826908017:2082]
2025-12-09T03:43:12.071028Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-09T03:43:12.071444Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-09T03:43:12.072042Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d20, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:12.077060Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:12.077086Z :FQ_PENDING_FETCHER ERROR: pending_fetcher.cpp:259: Error with GetTask: <main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:26045: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-syjwtgwtdu.auto.internal:26045
2025-12-09T03:43:13.072487Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d21, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:13.080658Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:13.080680Z :FQ_PENDING_FETCHER ERROR: pending_fetcher.cpp:259: Error with GetTask: <main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:26045: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-syjwtgwtdu.auto.internal:26045
2025-12-09T03:43:14.063717Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-12-09T03:43:14.068816Z :YQL_NODES_MANAGER ERROR: nodes_manager.cpp:395: ydb/core/fq/libs/actors/nodes_manager.cpp:353: TRANSPORT_UNAVAILABLE
<main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:26045: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-syjwtgwtdu.auto.internal:26045
2025-12-09T03:43:14.071889Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7581698636826908017:2082]
2025-12-09T03:43:14.071923Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-09T03:43:14.072364Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-09T03:43:14.072897Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d22, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:14.077864Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:14.077902Z :FQ_PENDING_FETCHER ERROR: pending_fetcher.cpp:259: Error with GetTask: <main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:26045: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-syjwtgwtdu.auto.internal:26045
2025-12-09T03:43:15.073381Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d23, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:15.078876Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:15.078897Z :FQ_PENDING_FETCHER ERROR: pending_fetcher.cpp:259: Error with GetTask: <main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:26045: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-syjwtgwtdu.auto.internal:26045
2025-12-09T03:43:16.072870Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7581698636826908017:2082]
2025-12-09T03:43:16.072902Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-09T03:43:16.073269Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-09T03:43:16.073789Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d24, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:16.079034Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:16.079057Z :FQ_PENDING_FETCHER ERROR: pending_fetcher.cpp:259: Error with GetTask: <main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:26045: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-syjwtgwtdu.auto.internal:26045
2025-12-09T03:43:17.074977Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d25, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:17.080083Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:17.080108Z :FQ_PENDING_FETCHER ERROR: pending_fetcher.cpp:259: Error with GetTask: <main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:26045: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-syjwtgwtdu.auto.internal:26045
2025-12-09T03:43:18.007847Z :INTERCONNECT_NETWORK NOTICE: interconnect_tcp_input_session.cpp:712: [2 <-> 1] connection closed by peer
2025-12-09T03:43:18.073705Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7581698636826908017:2082]
2025-12-09T03:43:18.073730Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-09T03:43:18.075748Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: ea8b6a46-9260eadd-e85a01da-f8bf6d5d26, Host: ghrun-syjwtgwtdu, Tenant: /compute
2025-12-09T03:43:18.080747Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-09T03:43:18.080766Z :FQ_PENDING_FETCHER ERROR: pending_fetcher.cpp:259: Error with GetTask: <main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:26045: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-syjwtgwtdu.auto.internal:26045
2025-12-09T03:43:18.119836Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:386: TLeaderElection [2:7581698642336289851:2093] Semaphore successfully acquired
2025-12-09T03:43:18.119880Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:438: TLeaderElection [2:7581698642336289851:2093] Semaphore changed
2025-12-09T03:43:18.119883Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:304: TLeaderElection [2:7581698642336289851:2093] Try to acquire semaphore
2025-12-09T03:43:18.120027Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:420: TLeaderElection [2:7581698642336289851:2093] Describe semaphore
2025-12-09T03:43:18.121664Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:386: TLeaderElection [2:7581698642336289851:2093] Semaphore successfully acquired
2025-12-09T03:43:18.121751Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:469: TLeaderElection [2:7581698642336289851:2093] Semaphore successfully described: coordinator id [2:7581698642336289850:2092] generation 7
2025-12-09T03:43:18.121760Z :FQ_ROW_DISPATCHER INFO: leader_election.cpp:471: TLeaderElection [2:7581698642336289851:2093] Send TEvCoordinatorChanged to [2:7581698642336289805:2063], new coordinator id [2:7581698642336289850:2092], previous coordinator id [1:7581698636826908017:2082]
2025-12-09T03:43:18.121780Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:569: RowDispatcher: Coordinator changed, old leader [1:7581698636826908017:2082], new [2:7581698642336289850:2092] generation 7
2025-12-09T03:43:18.121792Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:356: Coordinator: TEvPing received, [2:7581698642336289805:2063]
2025-12-09T03:43:18.121802Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [2:7581698642336289805:2063]
2025-12-09T03:43:18.121805Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:359: Coordinator: Send TEvPong to [2:7581698642336289805:2063]
2025-12-09T03:43:18.121825Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-09T03:43:18.121815Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:440: Coordinator: New leader [2:7581698642336289850:2092], SelfId [2:7581698642336289850:2092]
