2025-11-11T14:16:03.188099Z :GRPC_SERVER NOTICE: grpc_request_proxy_simple.cpp:161: Grpc simple request proxy started, nodeid# 1
2025-11-11T14:16:03.188810Z :GRPC_SERVER NOTICE: grpc_request_proxy_simple.cpp:161: Grpc simple request proxy started, nodeid# 1
2025-11-11T14:16:03.193147Z :YQ_CONTROL_PLANE_STORAGE INFO: ydb_control_plane_storage.cpp:50: Starting ydb control plane storage service. Actor id: [1:7571471415862912534:2062]
2025-11-11T14:16:03.193565Z :FQ_LOG_UPDATER DEBUG: log.cpp:93: Updated YQL logs priority: 8
2025-11-11T14:16:03.193572Z :FQ_LOG_UPDATER CRIT: log.cpp:55: Failed to deliver subscription request to config dispatcher.
2025-11-11T14:16:03.193587Z :FQ_CONTROL_PLANE_CONFIG DEBUG: control_plane_config.cpp:58: STARTING: [1:7571471415862912535:2063]
2025-11-11T14:16:03.195138Z :YQ_CONTROL_PLANE_PROXY DEBUG: control_plane_proxy.cpp:532: Starting yandex query control plane proxy. Actor id: [1:7571471415862912536:2064]
2025-11-11T14:16:03.200804Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:188: Bootstrap
2025-11-11T14:16:03.200807Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:191: Create sdk ydb connection
2025-11-11T14:16:03.200830Z :STREAMS_STORAGE_SERVICE TRACE: storage_proxy.cpp:213: Initialize
2025-11-11T14:16:03.201724Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:534: RowDispatcher: Successfully bootstrapped row dispatcher, id [1:7571471415862912541:2069], tenant /default
2025-11-11T14:16:03.201777Z :YQ_RATE_LIMITER INFO: quoter_service.cpp:124: Bootstraping with config: { Enabled: true ControlPlaneEnabled: true DataPlaneEnabled: true Database { Endpoint: "localhost:3770" Database: "local" TablePrefix: "RateLimiter_8938c89b-91ee-4433-b4ec-8fa5a24a4d51" } Limiters { CoordinationNodePath: "rate_limiter" } }
2025-11-11T14:16:03.201784Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:209: Successfully bootstrapped TStorageProxy [1:7571471415862912540:2068] with connection to localhost:3770:local
2025-11-11T14:16:03.201988Z :YQL_NODES_MANAGER INFO: nodes_manager.cpp:88: Bootstrap, InstanceId: 59d8f2d5-42c1bfb3-9e55e9a4-c1721b1c
2025-11-11T14:16:03.201989Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:310: TNodesManagerActor::ResolveSelfAddress
2025-11-11T14:16:03.202009Z :YQ_TEST_CONNECTION DEBUG: test_connection.cpp:142: Starting yandex query test connection. Actor id: [1:7571471415862912546:2074]
2025-11-11T14:16:03.210274Z :MEMORY_PROFILER NOTICE: monitor.cpp:332: Bootstrapped
2025-11-11T14:16:03.225688Z :FQ_QUOTA_PROXY INFO: quota_proxy.cpp:90: STARTED
2025-11-11T14:16:03.225800Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create directory "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51" actor
2025-11-11T14:16:03.225905Z :FQ_QUOTA_SERVICE INFO: quota_manager.cpp:196: STARTED
2025-11-11T14:16:03.225924Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create coordination node "local/RateLimiter_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/rate_limiter" actor
2025-11-11T14:16:03.225925Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create coordination node "local/RateLimiter_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/rate_limiter"
2025-11-11T14:16:03.225929Z :YQ_RATE_LIMITER DEBUG: schema.cpp:411: Call create coordination node "local/RateLimiter_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/rate_limiter"
2025-11-11T14:16:03.225953Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/queries" actor
2025-11-11T14:16:03.225973Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/pending_small" actor
2025-11-11T14:16:03.225982Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/connections" actor
2025-11-11T14:16:03.225993Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/bindings" actor
2025-11-11T14:16:03.226000Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/idempotency_keys" actor
2025-11-11T14:16:03.226006Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/result_sets" actor
2025-11-11T14:16:03.226080Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/jobs" actor
2025-11-11T14:16:03.226086Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/nodes" actor
2025-11-11T14:16:03.226095Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/quotas" actor
2025-11-11T14:16:03.226101Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/tenants" actor
2025-11-11T14:16:03.226107Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/tenant_acks" actor
2025-11-11T14:16:03.226462Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create directory "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51"
2025-11-11T14:16:03.226465Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:383: Call create directory "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51"
2025-11-11T14:16:03.226477Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/mappings" actor
2025-11-11T14:16:03.226485Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/compute_databases" actor
2025-11-11T14:16:03.226495Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:267: Coordinator: Successfully bootstrapped coordinator, id [1:7571471415862912600:2111], NodesManagerId [0:4705493345362661702:78]
2025-11-11T14:16:03.226501Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:232: TLeaderElection [1:7571471415862912601:2112] Successfully bootstrapped, local coordinator id [1:7571471415862912600:2111], tenant id default, local mode 0, coordination node path local/row_dispatcher/default, endpoint localhost:3770
2025-11-11T14:16:03.227256Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:627: RowDispatcher: TEvCoordinatorChangesSubscribe from [1:7571471415862912600:2111]
2025-11-11T14:16:03.227278Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-11-11T14:16:03.227289Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62271, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:16:03.232467Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:71: Run create coordination node "local/row_dispatcher/default" actor
2025-11-11T14:16:03.232477Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:113: Call create coordination node "local/row_dispatcher/default"
2025-11-11T14:16:03.232480Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:411: Call create coordination node "local/row_dispatcher/default"
2025-11-11T14:16:03.373220Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:155: Successfully created coordination node "local/row_dispatcher/default"
2025-11-11T14:16:03.373243Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:122: Reply for create coordination node "local/row_dispatcher/default": { <main>: Error: Check failed: path: '/local/row_dispatcher/default', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 12], type: EPathTypeKesus, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_kesus.cpp:339 }
2025-11-11T14:16:03.373283Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:345: TLeaderElection [1:7571471415862912601:2112] Coordination node successfully created
2025-11-11T14:16:03.373290Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:323: TLeaderElection [1:7571471415862912601:2112] Start session
2025-11-11T14:16:03.377350Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: d52b68ab-32bc4df5-5cc95d2a-575a62271, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:16:03.377360Z :FQ_CONTROL_PLANE_CONFIG WARN: control_plane_config.cpp:115: TEvGetTenantInfoRequest: IS NOT READY yet
2025-11-11T14:16:03.379071Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/result_sets". Create session OK
2025-11-11T14:16:03.379084Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/result_sets"
2025-11-11T14:16:03.379087Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/result_sets"
2025-11-11T14:16:03.379241Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/tenants". Create session OK
2025-11-11T14:16:03.379242Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/tenants"
2025-11-11T14:16:03.379243Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/tenants"
2025-11-11T14:16:03.379305Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/tenant_acks". Create session OK
2025-11-11T14:16:03.379307Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/tenant_acks"
2025-11-11T14:16:03.379308Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/tenant_acks"
2025-11-11T14:16:03.379355Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/idempotency_keys". Create session OK
2025-11-11T14:16:03.379356Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/idempotency_keys"
2025-11-11T14:16:03.379357Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/idempotency_keys"
2025-11-11T14:16:03.379410Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/quotas". Create session OK
2025-11-11T14:16:03.379411Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/quotas"
2025-11-11T14:16:03.379412Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/quotas"
2025-11-11T14:16:03.379463Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/pending_small". Create session OK
2025-11-11T14:16:03.379464Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/pending_small"
2025-11-11T14:16:03.379466Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/pending_small"
2025-11-11T14:16:03.416133Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/jobs". Create session OK
2025-11-11T14:16:03.416145Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/jobs"
2025-11-11T14:16:03.416147Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/jobs"
2025-11-11T14:16:03.416232Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/connections". Create session OK
2025-11-11T14:16:03.416237Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/connections"
2025-11-11T14:16:03.416239Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/connections"
2025-11-11T14:16:03.416293Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/compute_databases". Create session OK
2025-11-11T14:16:03.416295Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/compute_databases"
2025-11-11T14:16:03.416295Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/compute_databases"
2025-11-11T14:16:03.416339Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/bindings". Create session OK
2025-11-11T14:16:03.416341Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/bindings"
2025-11-11T14:16:03.416342Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/bindings"
2025-11-11T14:16:03.416392Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/queries". Create session OK
2025-11-11T14:16:03.416393Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/queries"
2025-11-11T14:16:03.416394Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/queries"
2025-11-11T14:16:03.416467Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/nodes". Create session OK
2025-11-11T14:16:03.416469Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/nodes"
2025-11-11T14:16:03.416470Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/nodes"
2025-11-11T14:16:03.416589Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created directory "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51"
2025-11-11T14:16:03.416598Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create directory "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51": { <main>: Error: Check failed: path: '/local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 50], type: EPathTypeDir, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_mkdir.cpp:155 }
2025-11-11T14:16:03.416607Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/mappings". Create session OK
2025-11-11T14:16:03.416610Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/mappings"
2025-11-11T14:16:03.416611Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/mappings"
2025-11-11T14:16:03.416685Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/tenants"
2025-11-11T14:16:03.416696Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/tenants": { <main>: Error: Check failed: path: '/local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/tenants', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 51], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504 }
2025-11-11T14:16:03.416776Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created coordination node "local/RateLimiter_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/rate_limiter"
2025-11-11T14:16:03.416780Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create coordination node "local/RateLimiter_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/rate_limiter": 
2025-11-11T14:16:03.416785Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/idempotency_keys"
2025-11-11T14:16:03.416786Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/idempotency_keys": 
2025-11-11T14:16:03.420096Z :YQ_CONTROL_PLANE_STORAGE TRACE: nodes_health_check.cpp:38: NodesHealthCheckRequest: {tenant: "/default"
node {
  node_id: 1
  instance_id: "59d8f2d5-42c1bfb3-9e55e9a4-c1721b1c"
  hostname: "ghrun-vb3yoermsa"
  interconnect_port: 22924
  node_address: "127.0.1.1"
}
}
2025-11-11T14:16:03.420171Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62271"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:16:03.420229Z :YQ_CONTROL_PLANE_STORAGE WARN: task_get.cpp:391: GetTaskRequest: {tenant: "/default"
owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62271"
host: "ghrun-vb3yoermsa"
node_id: 1
} FAILED: { <main>: Error: Control Plane is not ready yet. Please retry later., code: 1007 }
2025-11-11T14:16:03.420246Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: d52b68ab-32bc4df5-5cc95d2a-575a62271, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:16:03.420313Z :YQL_PRIVATE_PROXY ERROR: task_get.cpp:72: PrivateGetTask - Owner: d52b68ab-32bc4df5-5cc95d2a-575a62271, Host: ghrun-vb3yoermsa, Tenant: /default, Failed with code: GENERIC_ERROR Details: <main>: Error: Control Plane is not ready yet. Please retry later., code: 1007
<main>: Error: ControlPlane::GetTaskError
2025-11-11T14:16:03.420764Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:16:03.420775Z :FQ_PENDING_FETCHER ERROR: pending_fetcher.cpp:259: Error with GetTask: <main>: Error: Control Plane is not ready yet. Please retry later., code: 1007
<main>: Error: ControlPlane::GetTaskError
2025-11-11T14:16:03.624356Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/result_sets"
2025-11-11T14:16:03.624369Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/result_sets": 
2025-11-11T14:16:03.641337Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:359: TLeaderElection [1:7571471415862912601:2112] Session successfully created
2025-11-11T14:16:03.653511Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:372: TLeaderElection [1:7571471415862912601:2112] Semaphore successfully created
2025-11-11T14:16:03.653524Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:304: TLeaderElection [1:7571471415862912601:2112] Try to acquire semaphore
2025-11-11T14:16:03.653608Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:420: TLeaderElection [1:7571471415862912601:2112] Describe semaphore
2025-11-11T14:16:03.705870Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/quotas"
2025-11-11T14:16:03.705887Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/quotas": 
2025-11-11T14:16:03.705951Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/tenant_acks"
2025-11-11T14:16:03.705953Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/tenant_acks": 
2025-11-11T14:16:03.706675Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/mappings"
2025-11-11T14:16:03.706687Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/mappings": { <main>: Error: Check failed: path: '/local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/mappings', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 52], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504 }
2025-11-11T14:16:03.757655Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:386: TLeaderElection [1:7571471415862912601:2112] Semaphore successfully acquired
2025-11-11T14:16:03.764750Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:469: TLeaderElection [1:7571471415862912601:2112] Semaphore successfully described: coordinator id [1:7571471415862912600:2111] generation 3
2025-11-11T14:16:03.764765Z :FQ_ROW_DISPATCHER INFO: leader_election.cpp:471: TLeaderElection [1:7571471415862912601:2112] Send TEvCoordinatorChanged to [1:7571471415862912541:2069], new coordinator id [1:7571471415862912600:2111], previous coordinator id [0:0:0]
2025-11-11T14:16:03.764788Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:559: RowDispatcher: Coordinator changed, old leader (empty maybe), new [1:7571471415862912600:2111] generation 3
2025-11-11T14:16:03.764805Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:314: Coordinator: TEvPing received, [1:7571471415862912541:2069]
2025-11-11T14:16:03.764810Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:317: Coordinator: Send TEvPong to [1:7571471415862912541:2069]
2025-11-11T14:16:03.764837Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:386: Coordinator: New leader [1:7571471415862912600:2111], SelfId [1:7571471415862912600:2111]
2025-11-11T14:16:03.764856Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:623: RowDispatcher: NActors::TEvents::TEvPong
2025-11-11T14:16:03.768070Z :FQ_CONTROL_PLANE_CONFIG DEBUG: control_plane_config.cpp:190: LOADED TenantInfo: State CHANGED at 2025-11-11T14:16:00.074451Z
2025-11-11T14:16:03.768174Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:499: Checkpoint storage and state storage were successfully inited
2025-11-11T14:16:03.768197Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/queries"
2025-11-11T14:16:03.768201Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/queries": 
2025-11-11T14:16:03.768369Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/connections"
2025-11-11T14:16:03.768377Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/connections": 
2025-11-11T14:16:03.768456Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/pending_small"
2025-11-11T14:16:03.768463Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/pending_small": 
2025-11-11T14:16:03.768525Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/bindings"
2025-11-11T14:16:03.768533Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/bindings": 
2025-11-11T14:16:03.768588Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/nodes"
2025-11-11T14:16:03.768595Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/nodes": 
2025-11-11T14:16:03.768650Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/compute_databases"
2025-11-11T14:16:03.768658Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/compute_databases": 
2025-11-11T14:16:03.768722Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/jobs"
2025-11-11T14:16:03.768729Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/jobs": 
2025-11-11T14:16:03.861853Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: NodesHealthCheckRequest - NodesHealthCheckResult: {nodes { node_id: 1 instance_id: "59d8f2d5-42c1bfb3-9e55e9a4-c1721b1c" hostname: "ghrun-vb3yoermsa" node_address: "127.0.1.1" } } SUCCESS
2025-11-11T14:16:03.862374Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:389: Send NodeInfo with size: 0 to DynamicNameserver
2025-11-11T14:16:04.226184Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-11-11T14:16:04.226206Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-11-11T14:16:04.226215Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 1
2025-11-11T14:16:04.227210Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62272, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:16:04.227671Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: d52b68ab-32bc4df5-5cc95d2a-575a62272, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:16:04.227704Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62272"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:16:04.280878Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-11-11T14:16:04.280982Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: d52b68ab-32bc4df5-5cc95d2a-575a62272, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:16:04.282349Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:16:04.282357Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-11-11T14:16:05.185547Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:617: RowDispatcher: Send ping to [1:7571471415862912600:2111]
2025-11-11T14:16:05.185557Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1161: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-11T14:16:05.185636Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:314: Coordinator: TEvPing received, [1:7571471415862912541:2069]
2025-11-11T14:16:05.185641Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:317: Coordinator: Send TEvPong to [1:7571471415862912541:2069]
2025-11-11T14:16:05.185660Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:623: RowDispatcher: NActors::TEvents::TEvPong
2025-11-11T14:16:05.227684Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62273, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:16:05.233658Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: d52b68ab-32bc4df5-5cc95d2a-575a62273, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:16:05.233702Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62273"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:16:05.245690Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-11-11T14:16:05.245752Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: d52b68ab-32bc4df5-5cc95d2a-575a62273, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:16:05.248101Z :TICKET_PARSER DEBUG: ticket_parser_impl.h:1828: Ticket **** (B6C6F477) (ipv6:[::1]:38806) has now valid token of root@builtin
2025-11-11T14:16:05.248281Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:655: CreateQueryRequest: content {
  type: ANALYTICS
  name: "bad"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42 a"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "0ed65fdd-1900-4f8f-90eb-b4ac3c40c11a"
2025-11-11T14:16:05.248631Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471424452847255:2167]
2025-11-11T14:16:05.248658Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:16:05.248680Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:92: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7571471424452847256:2168]
2025-11-11T14:16:05.248694Z :FQ_QUOTA_SERVICE DEBUG: quota_manager.cpp:255: cloud.mock_cloud NOT CASHED, Loading ...
2025-11-11T14:16:05.249938Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:16:05.249948Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-11-11T14:16:05.277935Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:441: cloud.mock_cloud {} FROM DB
2025-11-11T14:16:05.277976Z :FQ_QUOTA_SERVICE DEBUG: quota_manager.cpp:269: cloud.mock_cloud{yq.streamingQueryDurationMinutes.count=*/0, yq.queryResult.size=*/20971520, yq.analyticsQuery.count=*/100, yq.analyticsQueryDurationMinutes.count=*/1440, yq.memory.size=*/0, yq.result.size=*/0, yq.cpuPercent.count=*/10000, yq.streamingQuery.count=*/100} LOADED
2025-11-11T14:16:05.277981Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-11-11T14:16:05.277997Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-11-11T14:16:05.278005Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-11-11T14:16:05.278057Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:703: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-11-11T14:16:05.337921Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:703: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-11-11T14:16:05.337944Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:703: cloud.mock_cloud.yq.streamingQuery.count=0/100 REFRESHED
2025-11-11T14:16:05.337962Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:493: cloud.mock_cloud{yq.streamingQueryDurationMinutes.count=*/0, yq.queryResult.size=*/20971520, yq.analyticsQuery.count=0/100, yq.analyticsQueryDurationMinutes.count=*/1440, yq.memory.size=*/0, yq.result.size=*/0, yq.cpuPercent.count=0/10000, yq.streamingQuery.count=0/100} SEND QUOTAS
2025-11-11T14:16:05.337977Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:108: Cloud id: mock_cloud Quota count: 8
2025-11-11T14:16:05.338123Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:655: CreateQueryRequest: content {
  type: ANALYTICS
  name: "bad"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42 a"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "0ed65fdd-1900-4f8f-90eb-b4ac3c40c11a"
2025-11-11T14:16:05.338356Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471424452847262:2174]
2025-11-11T14:16:05.338388Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:16:05.338434Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:655: CreateQueryRequest: content {
  type: ANALYTICS
  name: "bad"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42 a"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "0ed65fdd-1900-4f8f-90eb-b4ac3c40c11a"
2025-11-11T14:16:05.338446Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:444: Create database bootstrap. CloudId: mock_cloud Scope: yandexcloud://my_folder Actor id: [1:7571471424452847263:2175]
2025-11-11T14:16:05.338508Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:655: CreateQueryRequest: content {
  type: ANALYTICS
  name: "bad"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42 a"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "0ed65fdd-1900-4f8f-90eb-b4ac3c40c11a"
2025-11-11T14:16:05.338519Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471424452847264:2176]
2025-11-11T14:16:05.338534Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:253: Create rate limiter resource for cloud with limit 100000ms
2025-11-11T14:16:05.338567Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create rate limiter resource "mock_cloud" actor
2025-11-11T14:16:05.338569Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud"
2025-11-11T14:16:05.338990Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-11-11T14:16:05.342277Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created rate limiter resource "mock_cloud"
2025-11-11T14:16:05.342286Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create rate limiter resource "mock_cloud": 
2025-11-11T14:16:05.342314Z :YQ_CONTROL_PLANE_PROXY DEBUG: request_actor.h:277: Create response from rate limiter service. Success: 1
2025-11-11T14:16:05.342492Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:226: CreateQueryRequest: {content {
  type: ANALYTICS
  name: "bad"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42 a"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "0ed65fdd-1900-4f8f-90eb-b4ac3c40c11a"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:16:05.347138Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-11-11T14:16:05.350787Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=0/100 NOTIFY CHANGE
2025-11-11T14:16:05.496305Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: CreateQueryRequest - CreateQueryResult: {query_id: "ptqudslmr2lsm3gv40mr" } SUCCESS
2025-11-11T14:16:05.502912Z :TICKET_PARSER DEBUG: ticket_parser_impl.h:1828: Ticket **** (B6C6F477) (ipv6:[::1]:38806) has now valid token of root@builtin
2025-11-11T14:16:05.503022Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:05.503055Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471424452847269:2180]
2025-11-11T14:16:05.503069Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:16:05.503078Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:05.503108Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471424452847270:2181]
2025-11-11T14:16:05.503121Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:16:05.503129Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:05.503136Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471424452847271:2182]
2025-11-11T14:16:05.503165Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmr2lsm3gv40mr"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:16:05.538277Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmr2lsm3gv40mr" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870565 nanos: 342326000 } modified_at { seconds: 1762870565 nanos: 342326000 } revision: 1 } execute_mode: RUN status: STARTING last_job_query_revision: 1 last_job_id: "ptjudslmr2lslcu9f1jp-ptqudslmr2lsm3gv40mr" started_by: "root@builtin" submitted_at { seconds: 1762870565 nanos: 342326000 } } content { type: ANALYTICS name: "bad" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "SELECT 42 a" syntax: YQL_V1 } } } SUCCESS
2025-11-11T14:16:06.041660Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:06.041700Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471428747814571:2185]
2025-11-11T14:16:06.041725Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:16:06.041737Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:06.041763Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471428747814572:2186]
2025-11-11T14:16:06.041794Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:16:06.041837Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:06.041864Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471428747814573:2187]
2025-11-11T14:16:06.041950Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmr2lsm3gv40mr"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:16:06.044564Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmr2lsm3gv40mr" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870565 nanos: 342326000 } modified_at { seconds: 1762870565 nanos: 342326000 } revision: 1 } execute_mode: RUN status: STARTING last_job_query_revision: 1 last_job_id: "ptjudslmr2lslcu9f1jp-ptqudslmr2lsm3gv40mr" started_by: "root@builtin" submitted_at { seconds: 1762870565 nanos: 342326000 } } content { type: ANALYTICS name: "bad" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "SELECT 42 a" syntax: YQL_V1 } } } SUCCESS
2025-11-11T14:16:06.228091Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:16:06.229147Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:16:06.229203Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62274"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:16:06.237653Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-11-11T14:16:06.237763Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:463: Task (Query): ptqudslmr2lsm3gv40mr RetryRate: 0 RetryCounter: 0 At: 2025-11-11T14:16:05.450077Z
2025-11-11T14:16:06.350810Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {tasks { query_id { value: "ptqudslmr2lsm3gv40mr" } job_id { value: "ptjudslmr2lslcu9f1jp" } generation: 1 text: "SELECT 42 a" user_token: "root@builtin" user_id: "root@builtin" query_type: ANALYTICS scope: "yandexcloud://my_folder" execute_mode: RUN state_load_mode: EMPTY status: STARTING sensor_labels { key: "cloud_id" value: "mock_cloud" } sensor_labels { key: "scope" value: "yandexcloud://my_folder" } query_name: "bad" deadline { seconds: 1762956966 nanos: 292306000 } disposition { } result_limit: 20971520 execution_limit { seconds: 86400 } request_started_at { } resources { } query_syntax: YQL_V1 compute_connection { } result_ttl { seconds: 86400 } request_submitted_at { seconds: 1762870565 nanos: 342326000 } } } SUCCESS
2025-11-11T14:16:06.350866Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:16:06.351960Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:16:06.351972Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 1
2025-11-11T14:16:06.351986Z :FQ_PENDING_FETCHER DEBUG: pending_fetcher.cpp:361: NewTask: Scope: yandexcloud://my_folder Id: ptqudslmr2lsm3gv40mr UserId: root@builtin AuthToken: **** (B6C6F477)
2025-11-11T14:16:06.352289Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62275, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:16:06.352289Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:375: QueryId: ptqudslmr2lsm3gv40mr Start run actor. Compute state: STARTING
2025-11-11T14:16:06.352293Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:469: QueryId: ptqudslmr2lsm3gv40mr FillConnections
2025-11-11T14:16:06.352378Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:2333: QueryId: ptqudslmr2lsm3gv40mr Run actors params: { QueryId: ptqudslmr2lsm3gv40mr CloudId: mock_cloud UserId: root@builtin Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 PreviousQueryRevision: 1 Connections: 0 Bindings: 0 AccountIdSignatures: 0 QueryType: ANALYTICS ExecuteMode: RUN ResultId: ptrudslmr1n2r5fhjgvp StateLoadMode: EMPTY StreamingDisposition: {  } Status: STARTING DqGraphs: 0 DqGraphIndex: 0 Resource.TopicConsumers: 0 }
2025-11-11T14:16:06.352398Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:571: QueryId: ptqudslmr2lsm3gv40mr Start rate limiter resource creator
2025-11-11T14:16:06.352411Z :FQ_PINGER TRACE: pinger.cpp:171: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Start Pinger
2025-11-11T14:16:06.352448Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Forward ping request: { started_at { seconds: 1762870566 nanos: 352000000 } }
2025-11-11T14:16:06.352451Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Forward request Private::PingTask
2025-11-11T14:16:06.352468Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Forward ping request: { status: RUNNING resources { rate_limiter: PREPARE compilation: PREPARE } }
2025-11-11T14:16:06.352969Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: d52b68ab-32bc4df5-5cc95d2a-575a62275, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:16:06.353001Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62275"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:16:06.353122Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274, Request CP::PingTask with size: 129 bytes
2025-11-11T14:16:06.353129Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:78: PrivateCreateRateLimiterResource - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274, Request CP::CreateRateLimiterResource with size: 97 bytes
2025-11-11T14:16:06.353173Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: CreateRateLimiterResourceRequest: {owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62274"
query_id {
  value: "ptqudslmr2lsm3gv40mr"
}
scope: "yandexcloud://my_folder"
tenant: "/default"
} 
2025-11-11T14:16:06.353191Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62274"
query_id {
  value: "ptqudslmr2lsm3gv40mr"
}
scope: "yandexcloud://my_folder"
started_at {
  seconds: 1762870566
  nanos: 352000000
}
deadline {
  seconds: 1762956966
  nanos: 292306000
}
tenant: "/default"
}
2025-11-11T14:16:06.356066Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-11-11T14:16:06.356119Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: d52b68ab-32bc4df5-5cc95d2a-575a62275, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:16:06.356541Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:16:06.356548Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-11-11T14:16:06.387525Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: CreateRateLimiterResourceRequest. Got response from database: SUCCESS
2025-11-11T14:16:06.387649Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create rate limiter resource "mock_cloud/my_folder/ptqudslmr2lsm3gv40mr" actor
2025-11-11T14:16:06.387655Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder/ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:06.388511Z :YQ_RATE_LIMITER DEBUG: schema.cpp:261: Trying to recursively create rate limiter resource "mock_cloud/my_folder"
2025-11-11T14:16:06.388520Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder"
2025-11-11T14:16:06.389859Z :YQ_RATE_LIMITER DEBUG: schema.cpp:244: Successfully created rate limiter resource "mock_cloud/my_folder"
2025-11-11T14:16:06.389868Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder/ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:06.392358Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created rate limiter resource "mock_cloud/my_folder/ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:06.392367Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create rate limiter resource "mock_cloud/my_folder/ptqudslmr2lsm3gv40mr": 
2025-11-11T14:16:06.392415Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:180: Got create response from rate limiter service
2025-11-11T14:16:06.392442Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:102: PrivateCreateRateLimiterResource - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274, Got CP::CreateRateLimiterResourceResponse
2025-11-11T14:16:06.392726Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1477: QueryId: ptqudslmr2lsm3gv40mr Rate limiter resource creation finished. Success: 1
2025-11-11T14:16:06.392743Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1966: QueryId: ptqudslmr2lsm3gv40mr Compiling query ...
2025-11-11T14:16:06.392827Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Forward ping request: { status: RUNNING resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/rate_limiter" } }
2025-11-11T14:16:06.454398Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmr2lsm3gv40mr 2025-11-11 14:16:06.453 TRACE ydbd(pid=934917, tid=0x00007FA8EB672640) [perf] yql_facade.cpp:899: Execution of [ParseSql] took 57.7ms
2025-11-11T14:16:06.454615Z :FQ_RUN_ACTOR WARN: run_actor.cpp:1914: QueryId: ptqudslmr2lsm3gv40mr ResignQuery, status ABORTED
2025-11-11T14:16:06.454619Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1919: QueryId: ptqudslmr2lsm3gv40mr SendPingAndPassAway, FinalQueryStatus COMPUTE_STATUS_UNSPECIFIED
2025-11-11T14:16:06.454634Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:536: QueryId: ptqudslmr2lsm3gv40mr PassAway
2025-11-11T14:16:06.454723Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Forward ping request: {  }
2025-11-11T14:16:06.454771Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Forward ping request: { owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62274" query_id { value: "ptqudslmr2lsm3gv40mr" } result_id { } status: RUNNING resign_query: true transient_issues { message: "Failed to parse query" severity: 1 issues { message: "Parse Sql" severity: 1 issues { position { row: 1 column: 11 } message: "Expecting mandatory AS here. Did you miss comma? Please add PRAGMA AnsiOptionalAs; for ANSI compatibility" end_position { row: 1 column: 11 } severity: 1 } } } status_code: ABORTED resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/rate_limiter" } scope: "yandexcloud://my_folder" }
2025-11-11T14:16:06.544662Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870586 nanos: 476000000 } } SUCCESS
2025-11-11T14:16:06.544754Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274, Got CP::PingTaskResponse
2025-11-11T14:16:06.545326Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Ping response success: { expired_at { seconds: 1762870586 nanos: 476000000 } }
2025-11-11T14:16:06.545341Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Forward request Private::PingTask
2025-11-11T14:16:06.545841Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274, Request CP::PingTask with size: 123 bytes
2025-11-11T14:16:06.546112Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62274"
query_id {
  value: "ptqudslmr2lsm3gv40mr"
}
status: RUNNING
resources {
  rate_limiter: PREPARE
  compilation: PREPARE
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956966
  nanos: 292306000
}
tenant: "/default"
}
2025-11-11T14:16:06.547288Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:06.547325Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471428747814600:2213]
2025-11-11T14:16:06.547339Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:16:06.547350Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:06.547373Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471428747814601:2214]
2025-11-11T14:16:06.547385Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:16:06.547396Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:06.547405Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471428747814602:2215]
2025-11-11T14:16:06.547424Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmr2lsm3gv40mr"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:16:06.549305Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmr2lsm3gv40mr" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870565 nanos: 342326000 } modified_at { seconds: 1762870565 nanos: 342326000 } revision: 1 } started_at { seconds: 1762870566 nanos: 352000000 } execute_mode: RUN status: STARTING last_job_query_revision: 1 last_job_id: "ptjudslmr2lslcu9f1jp-ptqudslmr2lsm3gv40mr" started_by: "root@builtin" submitted_at { seconds: 1762870565 nanos: 342326000 } } content { type: ANALYTICS name: "bad" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "SELECT 42 a" syntax: YQL_V1 } } } SUCCESS
2025-11-11T14:16:06.563853Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870586 nanos: 556000000 } } SUCCESS
2025-11-11T14:16:06.563945Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274, Got CP::PingTaskResponse
2025-11-11T14:16:06.564339Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Ping response success: { expired_at { seconds: 1762870586 nanos: 556000000 } }
2025-11-11T14:16:06.564351Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Forward request Private::PingTask
2025-11-11T14:16:06.564682Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274, Request CP::PingTask with size: 192 bytes
2025-11-11T14:16:06.564736Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62274"
query_id {
  value: "ptqudslmr2lsm3gv40mr"
}
status: RUNNING
resources {
  rate_limiter: READY
  compilation: PREPARE
  rate_limiter_path: "local/RateLimiter_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/rate_limiter"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956966
  nanos: 292306000
}
tenant: "/default"
}
2025-11-11T14:16:06.579036Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870586 nanos: 573000000 } } SUCCESS
2025-11-11T14:16:06.579068Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274, Got CP::PingTaskResponse
2025-11-11T14:16:06.579481Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Ping response success: { expired_at { seconds: 1762870586 nanos: 573000000 } }
2025-11-11T14:16:06.579495Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Forward request Private::PingTask
2025-11-11T14:16:06.579903Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274, Request CP::PingTask with size: 114 bytes
2025-11-11T14:16:06.579981Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62274"
query_id {
  value: "ptqudslmr2lsm3gv40mr"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956966
  nanos: 292306000
}
tenant: "/default"
}
2025-11-11T14:16:06.663777Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870586 nanos: 627000000 } } SUCCESS
2025-11-11T14:16:06.663804Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274, Got CP::PingTaskResponse
2025-11-11T14:16:06.664170Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Ping response success: { expired_at { seconds: 1762870586 nanos: 627000000 } }
2025-11-11T14:16:06.664188Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Forward request Private::PingTask
2025-11-11T14:16:06.664610Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274, Request CP::PingTask with size: 367 bytes
2025-11-11T14:16:06.664719Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62274"
query_id {
  value: "ptqudslmr2lsm3gv40mr"
}
result_id {
}
status: RUNNING
resign_query: true
transient_issues {
  message: "Failed to parse query"
  severity: 1
  issues {
    message: "Parse Sql"
    severity: 1
    issues {
      position {
        row: 1
        column: 11
      }
      message: "Expecting mandatory AS here. Did you miss comma? Please add PRAGMA AnsiOptionalAs; for ANSI compatibility"
      end_position {
        row: 1
        column: 11
      }
      severity: 1
    }
  }
}
status_code: ABORTED
resources {
  rate_limiter: READY
  compilation: PREPARE
  rate_limiter_path: "local/RateLimiter_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/rate_limiter"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956966
  nanos: 292306000
}
tenant: "/default"
}
2025-11-11T14:16:06.670678Z :YQ_CONTROL_PLANE_STORAGE DEBUG: task_ping.cpp:427: PingTaskRequest (resign):  FAILURE ABORTED 0 2025-11-11T14:16:05.450077Z 0.000000s
2025-11-11T14:16:06.739760Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870566 nanos: 670000000 } } SUCCESS
2025-11-11T14:16:06.739847Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274, Got CP::PingTaskResponse
2025-11-11T14:16:06.742080Z :FQ_PINGER ERROR: pinger.cpp:365: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Ping response error: Query ownership time is over: expired_at=2025-11-11T14:16:06.670000Z < now=2025-11-11T14:16:06.741158Z. Retried 0 times during 0.081970s
2025-11-11T14:16:06.742104Z :FQ_PINGER DEBUG: pinger.cpp:379: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Query finished
2025-11-11T14:16:06.742106Z :FQ_PINGER TRACE: pinger.cpp:187: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62274 Stop Pinger
2025-11-11T14:16:07.053710Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:07.053770Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471433042781911:2227]
2025-11-11T14:16:07.053791Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:16:07.053806Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:07.053840Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471433042781912:2228]
2025-11-11T14:16:07.053859Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:16:07.053869Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:07.053879Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471433042781913:2229]
2025-11-11T14:16:07.053905Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmr2lsm3gv40mr"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:16:07.069753Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmr2lsm3gv40mr" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870565 nanos: 342326000 } modified_at { seconds: 1762870565 nanos: 342326000 } revision: 1 } started_at { seconds: 1762870566 nanos: 352000000 } execute_mode: RUN status: FAILING last_job_query_revision: 1 last_job_id: "ptjudslmr2lslcu9f1jp-ptqudslmr2lsm3gv40mr" started_by: "root@builtin" submitted_at { seconds: 1762870565 nanos: 342326000 } } content { type: ANALYTICS name: "bad" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "SELECT 42 a" syntax: YQL_V1 } issue { message: "Query failed with code ABORTED at 2025-11-11T14:16:06.670652Z" severity: 1 issues { message: "Failed to parse query" severity: 1 issues { message: "Parse Sql" severity: 1 issues { position { row: 1 column: 11 } message: "Expecting mandatory AS here. Did you miss comma? Please add PRAGMA AnsiOptionalAs; for ANSI compatibility" end_position { row: 1 column: 11 } severity: 1 } } } } } } SUCCESS
2025-11-11T14:16:07.187198Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:617: RowDispatcher: Send ping to [1:7571471415862912600:2111]
2025-11-11T14:16:07.187215Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1161: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-11T14:16:07.187265Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:314: Coordinator: TEvPing received, [1:7571471415862912541:2069]
2025-11-11T14:16:07.187272Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:317: Coordinator: Send TEvPong to [1:7571471415862912541:2069]
2025-11-11T14:16:07.187280Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:623: RowDispatcher: NActors::TEvents::TEvPong
2025-11-11T14:16:07.228566Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62276, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:16:07.229745Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: d52b68ab-32bc4df5-5cc95d2a-575a62276, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:16:07.229794Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62276"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:16:07.237747Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:456: Task (Query): ptqudslmr2lsm3gv40mr Lease TIMEOUT, RetryCounterUpdatedAt 2025-11-11T14:16:05.450077Z LastSeenAt: 2025-11-11T14:16:06.670744Z
2025-11-11T14:16:07.237761Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:463: Task (Query): ptqudslmr2lsm3gv40mr RetryRate: 1.999717438 RetryCounter: 1 At: 2025-11-11T14:16:07.237698Z
2025-11-11T14:16:07.254050Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {tasks { query_id { value: "ptqudslmr2lsm3gv40mr" } job_id { value: "ptjudslmr2lslcu9f1jp" } generation: 2 text: "SELECT 42 a" user_token: "root@builtin" user_id: "root@builtin" query_type: ANALYTICS scope: "yandexcloud://my_folder" execute_mode: RUN state_load_mode: EMPTY status: FAILING sensor_labels { key: "cloud_id" value: "mock_cloud" } sensor_labels { key: "scope" value: "yandexcloud://my_folder" } query_name: "bad" deadline { seconds: 1762956967 nanos: 245581000 } disposition { } result_limit: 20971520 execution_limit { seconds: 86400 } request_started_at { seconds: 1762870566 nanos: 352000000 } restart_count: 1 resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/rate_limiter" } query_syntax: YQL_V1 compute_connection { } result_ttl { seconds: 86400 } request_submitted_at { seconds: 1762870565 nanos: 342326000 } } } SUCCESS
2025-11-11T14:16:07.254089Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: d52b68ab-32bc4df5-5cc95d2a-575a62276, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:16:07.254480Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:16:07.254489Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 1
2025-11-11T14:16:07.254500Z :FQ_PENDING_FETCHER DEBUG: pending_fetcher.cpp:361: NewTask: Scope: yandexcloud://my_folder Id: ptqudslmr2lsm3gv40mr UserId: root@builtin AuthToken: **** (B6C6F477)
2025-11-11T14:16:07.254639Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62277, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:16:07.254660Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:375: QueryId: ptqudslmr2lsm3gv40mr Start run actor. Compute state: FAILING
2025-11-11T14:16:07.254661Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:469: QueryId: ptqudslmr2lsm3gv40mr FillConnections
2025-11-11T14:16:07.254674Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:2333: QueryId: ptqudslmr2lsm3gv40mr Run actors params: { QueryId: ptqudslmr2lsm3gv40mr CloudId: mock_cloud UserId: root@builtin Owner: d52b68ab-32bc4df5-5cc95d2a-575a62276 PreviousQueryRevision: 2 Connections: 0 Bindings: 0 AccountIdSignatures: 0 QueryType: ANALYTICS ExecuteMode: RUN ResultId: ptrudslmr0rhflpujrks StateLoadMode: EMPTY StreamingDisposition: {  } Status: FAILING DqGraphs: 0 DqGraphIndex: 0 Resource.TopicConsumers: 0 }
2025-11-11T14:16:07.254683Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1827: QueryId: ptqudslmr2lsm3gv40mr Is about to finish query with status FAILED
2025-11-11T14:16:07.254689Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1508: QueryId: ptqudslmr2lsm3gv40mr Start rate limiter resource deleter
2025-11-11T14:16:07.254862Z :FQ_PINGER TRACE: pinger.cpp:171: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62276 Start Pinger
2025-11-11T14:16:07.255049Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: d52b68ab-32bc4df5-5cc95d2a-575a62277, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:16:07.255101Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62277"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:16:07.255224Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:175: PrivateDeleteRateLimiterResource - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62276, Request CP::DeleteRateLimiterResource with size: 97 bytes
2025-11-11T14:16:07.255259Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: DeleteRateLimiterResourceRequest: {owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62276"
query_id {
  value: "ptqudslmr2lsm3gv40mr"
}
scope: "yandexcloud://my_folder"
tenant: "/default"
} 
2025-11-11T14:16:07.260538Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-11-11T14:16:07.260609Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: d52b68ab-32bc4df5-5cc95d2a-575a62277, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:16:07.261116Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:16:07.261122Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-11-11T14:16:07.299270Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: DeleteRateLimiterResourceRequest. Got response from database: SUCCESS
2025-11-11T14:16:07.299343Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run delete rate limiter resource "mock_cloud/my_folder/ptqudslmr2lsm3gv40mr" actor
2025-11-11T14:16:07.299345Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call delete rate limiter resource "mock_cloud/my_folder/ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:07.309513Z :YQ_RATE_LIMITER DEBUG: schema.cpp:179: Successfully deleted rate limiter resource "mock_cloud/my_folder/ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:07.309519Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for delete rate limiter resource "mock_cloud/my_folder/ptqudslmr2lsm3gv40mr": 
2025-11-11T14:16:07.309554Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:219: Got delete response from rate limiter service
2025-11-11T14:16:07.309586Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:199: PrivateDeleteRateLimiterResource - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62276, Got CP::DeleteRateLimiterResourceResponse
2025-11-11T14:16:07.317603Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1499: QueryId: ptqudslmr2lsm3gv40mr Rate limiter resource deletion finished. Success: 1. Issues: 
2025-11-11T14:16:07.317620Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1919: QueryId: ptqudslmr2lsm3gv40mr SendPingAndPassAway, FinalQueryStatus FAILED
2025-11-11T14:16:07.317639Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:536: QueryId: ptqudslmr2lsm3gv40mr PassAway
2025-11-11T14:16:07.317788Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62276 Forward ping request: { result_id { } status: FAILED resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/rate_limiter" } finished_at { seconds: 1762870567 nanos: 254000000 } }
2025-11-11T14:16:07.317793Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62276 Forward request Private::PingTask
2025-11-11T14:16:07.318289Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62276, Request CP::PingTask with size: 207 bytes
2025-11-11T14:16:07.318369Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "d52b68ab-32bc4df5-5cc95d2a-575a62276"
query_id {
  value: "ptqudslmr2lsm3gv40mr"
}
result_id {
}
status: FAILED
resources {
  rate_limiter: READY
  compilation: PREPARE
  rate_limiter_path: "local/RateLimiter_8938c89b-91ee-4433-b4ec-8fa5a24a4d51/rate_limiter"
}
scope: "yandexcloud://my_folder"
finished_at {
  seconds: 1762870567
  nanos: 254000000
}
deadline {
  seconds: 1762956967
  nanos: 245581000
}
tenant: "/default"
}
2025-11-11T14:16:07.327177Z :YQ_CONTROL_PLANE_STORAGE NOTICE: task_ping.cpp:224: Query ptqudslmr2lsm3gv40mr is NOT billable, status: FAILED, statusCode: ABORTED
2025-11-11T14:16:07.401954Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {} SUCCESS
2025-11-11T14:16:07.401986Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62276, Got CP::PingTaskResponse
2025-11-11T14:16:07.402402Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62276 Ping response success: {  }
2025-11-11T14:16:07.402415Z :FQ_PINGER DEBUG: pinger.cpp:379: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62276 Query finished
2025-11-11T14:16:07.402418Z :FQ_PINGER TRACE: pinger.cpp:187: QueryId: ptqudslmr2lsm3gv40mr, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62276 Stop Pinger
2025-11-11T14:16:07.572327Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:07.572363Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471433042781935:2250]
2025-11-11T14:16:07.572384Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:16:07.572436Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:07.572519Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471433042781936:2251]
2025-11-11T14:16:07.572561Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:16:07.572581Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:07.572606Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471433042781937:2252]
2025-11-11T14:16:07.572641Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmr2lsm3gv40mr"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:16:07.575311Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmr2lsm3gv40mr" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870565 nanos: 342326000 } modified_at { seconds: 1762870565 nanos: 342326000 } revision: 1 } started_at { seconds: 1762870566 nanos: 352000000 } finished_at { seconds: 1762870567 nanos: 254000000 } execute_mode: RUN status: FAILED last_job_query_revision: 1 last_job_id: "ptjudslmr2lslcu9f1jp-ptqudslmr2lsm3gv40mr" started_by: "root@builtin" submitted_at { seconds: 1762870565 nanos: 342326000 } } content { type: ANALYTICS name: "bad" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "SELECT 42 a" syntax: YQL_V1 } issue { message: "Query failed with code ABORTED at 2025-11-11T14:16:06.670652Z" severity: 1 issues { message: "Failed to parse query" severity: 1 issues { message: "Parse Sql" severity: 1 issues { position { row: 1 column: 11 } message: "Expecting mandatory AS here. Did you miss comma? Please add PRAGMA AnsiOptionalAs; for ANSI compatibility" end_position { row: 1 column: 11 } severity: 1 } } } } } } SUCCESS
2025-11-11T14:16:07.577717Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:07.577745Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471433042781941:2255]
2025-11-11T14:16:07.577769Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:16:07.577809Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:07.577851Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471433042781942:2256]
2025-11-11T14:16:07.577868Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:16:07.577911Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmr2lsm3gv40mr"
2025-11-11T14:16:07.577952Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471433042781943:2257]
2025-11-11T14:16:07.577984Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmr2lsm3gv40mr"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:16:07.580161Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmr2lsm3gv40mr" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870565 nanos: 342326000 } modified_at { seconds: 1762870565 nanos: 342326000 } revision: 1 } started_at { seconds: 1762870566 nanos: 352000000 } finished_at { seconds: 1762870567 nanos: 254000000 } execute_mode: RUN status: FAILED last_job_query_revision: 1 last_job_id: "ptjudslmr2lslcu9f1jp-ptqudslmr2lsm3gv40mr" started_by: "root@builtin" submitted_at { seconds: 1762870565 nanos: 342326000 } } content { type: ANALYTICS name: "bad" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "SELECT 42 a" syntax: YQL_V1 } issue { message: "Query failed with code ABORTED at 2025-11-11T14:16:06.670652Z" severity: 1 issues { message: "Failed to parse query" severity: 1 issues { message: "Parse Sql" severity: 1 issues { position { row: 1 column: 11 } message: "Expecting mandatory AS here. Did you miss comma? Please add PRAGMA AnsiOptionalAs; for ANSI compatibility" end_position { row: 1 column: 11 } severity: 1 } } } } } } SUCCESS
2025-11-11T14:16:08.227018Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-11-11T14:16:08.229511Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62278, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:16:08.232287Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:16:08.232307Z :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:15418: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-vb3yoermsa.auto.internal:15418
2025-11-11T14:16:08.232496Z :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:15418: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-vb3yoermsa.auto.internal:15418
2025-11-11T14:16:09.187508Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:617: RowDispatcher: Send ping to [1:7571471415862912600:2111]
2025-11-11T14:16:09.187531Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1161: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-11T14:16:09.187539Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:314: Coordinator: TEvPing received, [1:7571471415862912541:2069]
2025-11-11T14:16:09.187543Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:317: Coordinator: Send TEvPong to [1:7571471415862912541:2069]
2025-11-11T14:16:09.187555Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:623: RowDispatcher: NActors::TEvents::TEvPong
2025-11-11T14:16:09.230518Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: d52b68ab-32bc4df5-5cc95d2a-575a62279, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:16:09.231872Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-11-11T14:16:09.341060Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:16:09.341085Z :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:15418: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-vb3yoermsa.auto.internal:15418
