2025-11-11T14:15:36.202520Z :GRPC_SERVER NOTICE: grpc_request_proxy_simple.cpp:161: Grpc simple request proxy started, nodeid# 1
2025-11-11T14:15:36.202588Z :GRPC_SERVER NOTICE: grpc_request_proxy_simple.cpp:161: Grpc simple request proxy started, nodeid# 1
2025-11-11T14:15:36.202897Z :FQ_LOG_UPDATER DEBUG: log.cpp:93: Updated YQL logs priority: 8
2025-11-11T14:15:36.202901Z :FQ_LOG_UPDATER CRIT: log.cpp:55: Failed to deliver subscription request to config dispatcher.
2025-11-11T14:15:36.202911Z :YQ_CONTROL_PLANE_STORAGE INFO: ydb_control_plane_storage.cpp:50: Starting ydb control plane storage service. Actor id: [1:7571471300149523831:2062]
2025-11-11T14:15:36.202936Z :FQ_CONTROL_PLANE_CONFIG DEBUG: control_plane_config.cpp:58: STARTING: [1:7571471300149523832:2063]
2025-11-11T14:15:36.221084Z :YQ_CONTROL_PLANE_PROXY DEBUG: control_plane_proxy.cpp:532: Starting yandex query control plane proxy. Actor id: [1:7571471300149523833:2064]
2025-11-11T14:15:36.221194Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:188: Bootstrap
2025-11-11T14:15:36.221197Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:191: Create sdk ydb connection
2025-11-11T14:15:36.221232Z :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_c68853c5-29df-4a95-a52e-3dbc313cd4e2" } Limiters { CoordinationNodePath: "rate_limiter" } }
2025-11-11T14:15:36.221321Z :STREAMS_STORAGE_SERVICE TRACE: storage_proxy.cpp:213: Initialize
2025-11-11T14:15:36.221465Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:209: Successfully bootstrapped TStorageProxy [1:7571471300149523837:2068] with connection to localhost:3770:local
2025-11-11T14:15:36.221474Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:534: RowDispatcher: Successfully bootstrapped row dispatcher, id [1:7571471300149523838:2069], tenant /default
2025-11-11T14:15:36.221556Z :YQL_NODES_MANAGER INFO: nodes_manager.cpp:88: Bootstrap, InstanceId: f844ff72-449ac1af-3fe22bb4-ffb771e
2025-11-11T14:15:36.221558Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:310: TNodesManagerActor::ResolveSelfAddress
2025-11-11T14:15:36.221568Z :YQ_TEST_CONNECTION DEBUG: test_connection.cpp:142: Starting yandex query test connection. Actor id: [1:7571471300149523843:2074]
2025-11-11T14:15:36.221627Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2061, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:36.221636Z :FQ_QUOTA_PROXY INFO: quota_proxy.cpp:90: STARTED
2025-11-11T14:15:36.221681Z :FQ_QUOTA_SERVICE INFO: quota_manager.cpp:196: STARTED
2025-11-11T14:15:36.221700Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create directory "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2" actor
2025-11-11T14:15:36.221702Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create directory "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2"
2025-11-11T14:15:36.221704Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:383: Call create directory "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2"
2025-11-11T14:15:36.221725Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/queries" actor
2025-11-11T14:15:36.221737Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/pending_small" actor
2025-11-11T14:15:36.221741Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/connections" actor
2025-11-11T14:15:36.221747Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/bindings" actor
2025-11-11T14:15:36.221758Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/idempotency_keys" actor
2025-11-11T14:15:36.221770Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/result_sets" actor
2025-11-11T14:15:36.221773Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/jobs" actor
2025-11-11T14:15:36.221778Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/nodes" actor
2025-11-11T14:15:36.221785Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/quotas" actor
2025-11-11T14:15:36.221788Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/tenants" actor
2025-11-11T14:15:36.221796Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/tenant_acks" actor
2025-11-11T14:15:36.221797Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/mappings" actor
2025-11-11T14:15:36.221808Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/compute_databases" actor
2025-11-11T14:15:36.221812Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create coordination node "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter" actor
2025-11-11T14:15:36.221814Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create coordination node "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter"
2025-11-11T14:15:36.221816Z :YQ_RATE_LIMITER DEBUG: schema.cpp:411: Call create coordination node "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter"
2025-11-11T14:15:36.221822Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:267: Coordinator: Successfully bootstrapped coordinator, id [1:7571471300149523897:2111], NodesManagerId [0:4705493345362661702:78]
2025-11-11T14:15:36.221832Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:232: TLeaderElection [1:7571471300149523898:2112] Successfully bootstrapped, local coordinator id [1:7571471300149523897:2111], tenant id default, local mode 0, coordination node path local/row_dispatcher/default, endpoint localhost:3770
2025-11-11T14:15:36.242131Z :MEMORY_PROFILER NOTICE: monitor.cpp:332: Bootstrapped
2025-11-11T14:15:36.242286Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:627: RowDispatcher: TEvCoordinatorChangesSubscribe from [1:7571471300149523897:2111]
2025-11-11T14:15:36.242498Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-11-11T14:15:36.247265Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:71: Run create coordination node "local/row_dispatcher/default" actor
2025-11-11T14:15:36.247277Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:113: Call create coordination node "local/row_dispatcher/default"
2025-11-11T14:15:36.247281Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:411: Call create coordination node "local/row_dispatcher/default"
2025-11-11T14:15:36.274213Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:36.274234Z :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.0.1:25108: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint localhost:25108
2025-11-11T14:15:36.274282Z :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.0.1:25108: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint localhost:25108
2025-11-11T14:15:36.305120Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/compute_databases". Create session OK
2025-11-11T14:15:36.305134Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/compute_databases"
2025-11-11T14:15:36.305137Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/compute_databases"
2025-11-11T14:15:36.305388Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/nodes". Create session OK
2025-11-11T14:15:36.305394Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/nodes"
2025-11-11T14:15:36.305396Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/nodes"
2025-11-11T14:15:36.305500Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/result_sets". Create session OK
2025-11-11T14:15:36.305502Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/result_sets"
2025-11-11T14:15:36.305503Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/result_sets"
2025-11-11T14:15:36.305562Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/quotas". Create session OK
2025-11-11T14:15:36.305564Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/quotas"
2025-11-11T14:15:36.305564Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/quotas"
2025-11-11T14:15:36.305586Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/queries". Create session OK
2025-11-11T14:15:36.305593Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/queries"
2025-11-11T14:15:36.305595Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/queries"
2025-11-11T14:15:36.305731Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/idempotency_keys". Create session OK
2025-11-11T14:15:36.330360Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/idempotency_keys"
2025-11-11T14:15:36.330374Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/idempotency_keys"
2025-11-11T14:15:36.330570Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/mappings". Create session OK
2025-11-11T14:15:36.330575Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/mappings"
2025-11-11T14:15:36.330576Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/mappings"
2025-11-11T14:15:36.330600Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/jobs". Create session OK
2025-11-11T14:15:36.330605Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/jobs"
2025-11-11T14:15:36.330607Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/jobs"
2025-11-11T14:15:36.330612Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/tenant_acks". Create session OK
2025-11-11T14:15:36.330617Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/tenant_acks"
2025-11-11T14:15:36.330619Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/tenant_acks"
2025-11-11T14:15:36.330653Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/bindings". Create session OK
2025-11-11T14:15:36.330655Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/bindings"
2025-11-11T14:15:36.330656Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/bindings"
2025-11-11T14:15:36.330715Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/pending_small". Create session OK
2025-11-11T14:15:36.330717Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/pending_small"
2025-11-11T14:15:36.330718Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/pending_small"
2025-11-11T14:15:36.330719Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/tenants". Create session OK
2025-11-11T14:15:36.330722Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/tenants"
2025-11-11T14:15:36.330723Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/tenants"
2025-11-11T14:15:36.330738Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/connections". Create session OK
2025-11-11T14:15:36.330741Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/connections"
2025-11-11T14:15:36.330743Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/connections"
2025-11-11T14:15:36.330779Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created directory "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2"
2025-11-11T14:15:36.330787Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create directory "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2": { <main>: Error: Check failed: path: '/local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 2], type: EPathTypeDir, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_mkdir.cpp:155 }
2025-11-11T14:15:36.331942Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created coordination node "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter"
2025-11-11T14:15:36.331946Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create coordination node "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter": 
2025-11-11T14:15:36.339734Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/mappings"
2025-11-11T14:15:36.339754Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/mappings": { <main>: Error: Check failed: path: '/local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/mappings', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 4], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504 }
2025-11-11T14:15:36.340026Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/tenants"
2025-11-11T14:15:36.340052Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/tenants": { <main>: Error: Check failed: path: '/local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/tenants', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 3], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504 }
2025-11-11T14:15:36.342259Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:155: Successfully created coordination node "local/row_dispatcher/default"
2025-11-11T14:15:36.342272Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:122: Reply for create coordination node "local/row_dispatcher/default": 
2025-11-11T14:15:36.342291Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:345: TLeaderElection [1:7571471300149523898:2112] Coordination node successfully created
2025-11-11T14:15:36.342293Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:323: TLeaderElection [1:7571471300149523898:2112] Start session
2025-11-11T14:15:36.352084Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/compute_databases"
2025-11-11T14:15:36.352095Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/compute_databases": 
2025-11-11T14:15:36.352182Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/nodes"
2025-11-11T14:15:36.352190Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/nodes": 
2025-11-11T14:15:36.353472Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:359: TLeaderElection [1:7571471300149523898:2112] Session successfully created
2025-11-11T14:15:36.360971Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/result_sets"
2025-11-11T14:15:36.360994Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/result_sets": 
2025-11-11T14:15:36.362327Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:372: TLeaderElection [1:7571471300149523898:2112] Semaphore successfully created
2025-11-11T14:15:36.362338Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:304: TLeaderElection [1:7571471300149523898:2112] Try to acquire semaphore
2025-11-11T14:15:36.362397Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:420: TLeaderElection [1:7571471300149523898:2112] Describe semaphore
2025-11-11T14:15:36.363586Z :FQ_CONTROL_PLANE_CONFIG DEBUG: control_plane_config.cpp:190: LOADED TenantInfo: State CHANGED at 2025-11-11T14:15:35.347241Z
2025-11-11T14:15:36.369587Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:386: TLeaderElection [1:7571471300149523898:2112] Semaphore successfully acquired
2025-11-11T14:15:36.369611Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:469: TLeaderElection [1:7571471300149523898:2112] Semaphore successfully described: coordinator id [1:7571471300149523897:2111] generation 1
2025-11-11T14:15:36.369615Z :FQ_ROW_DISPATCHER INFO: leader_election.cpp:471: TLeaderElection [1:7571471300149523898:2112] Send TEvCoordinatorChanged to [1:7571471300149523838:2069], new coordinator id [1:7571471300149523897:2111], previous coordinator id [0:0:0]
2025-11-11T14:15:36.369635Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:559: RowDispatcher: Coordinator changed, old leader (empty maybe), new [1:7571471300149523897:2111] generation 1
2025-11-11T14:15:36.369650Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:314: Coordinator: TEvPing received, [1:7571471300149523838:2069]
2025-11-11T14:15:36.369653Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:317: Coordinator: Send TEvPong to [1:7571471300149523838:2069]
2025-11-11T14:15:36.369659Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:386: Coordinator: New leader [1:7571471300149523897:2111], SelfId [1:7571471300149523897:2111]
2025-11-11T14:15:36.369662Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:623: RowDispatcher: NActors::TEvents::TEvPong
2025-11-11T14:15:36.381641Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/quotas"
2025-11-11T14:15:36.381653Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/quotas": 
2025-11-11T14:15:36.381696Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/jobs"
2025-11-11T14:15:36.381703Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/jobs": 
2025-11-11T14:15:36.381844Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/tenant_acks"
2025-11-11T14:15:36.381852Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/tenant_acks": 
2025-11-11T14:15:36.381862Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/pending_small"
2025-11-11T14:15:36.381865Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/pending_small": 
2025-11-11T14:15:36.381911Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/idempotency_keys"
2025-11-11T14:15:36.381913Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/idempotency_keys": 
2025-11-11T14:15:36.381942Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/queries"
2025-11-11T14:15:36.381944Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/queries": 
2025-11-11T14:15:36.381958Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/bindings"
2025-11-11T14:15:36.381960Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/bindings": 
2025-11-11T14:15:36.381995Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/connections"
2025-11-11T14:15:36.381997Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_c68853c5-29df-4a95-a52e-3dbc313cd4e2/connections": 
2025-11-11T14:15:36.387911Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:499: Checkpoint storage and state storage were successfully inited
2025-11-11T14:15:36.866036Z :TICKET_PARSER DEBUG: ticket_parser_impl.h:1828: Ticket **** (B6C6F477) (ipv6:[::1]:43362) has now valid token of root@builtin
2025-11-11T14:15:36.866176Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:655: CreateQueryRequest: content {
  type: ANALYTICS
  name: "q"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "43b80d86-c743-4b57-a8c7-96d0e2e9d729"
2025-11-11T14:15:36.866224Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471300149523949:2156]
2025-11-11T14:15:36.866247Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:36.866271Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:92: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7571471300149523950:2157]
2025-11-11T14:15:36.866297Z :FQ_QUOTA_SERVICE DEBUG: quota_manager.cpp:255: cloud.mock_cloud NOT CASHED, Loading ...
2025-11-11T14:15:36.897526Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:441: cloud.mock_cloud {} FROM DB
2025-11-11T14:15:36.897563Z :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:15:36.897567Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-11-11T14:15:36.897597Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-11-11T14:15:36.897601Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-11-11T14:15:36.897634Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:703: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-11-11T14:15:36.954006Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-11-11T14:15:36.971923Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:703: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-11-11T14:15:36.971953Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:703: cloud.mock_cloud.yq.streamingQuery.count=0/100 REFRESHED
2025-11-11T14:15:36.971979Z :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:15:36.972018Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:108: Cloud id: mock_cloud Quota count: 8
2025-11-11T14:15:36.972086Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:655: CreateQueryRequest: content {
  type: ANALYTICS
  name: "q"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "43b80d86-c743-4b57-a8c7-96d0e2e9d729"
2025-11-11T14:15:36.972162Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471300149523956:2163]
2025-11-11T14:15:36.972191Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:36.972230Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:655: CreateQueryRequest: content {
  type: ANALYTICS
  name: "q"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "43b80d86-c743-4b57-a8c7-96d0e2e9d729"
2025-11-11T14:15:36.972263Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:444: Create database bootstrap. CloudId: mock_cloud Scope: yandexcloud://my_folder Actor id: [1:7571471300149523957:2164]
2025-11-11T14:15:36.972305Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:655: CreateQueryRequest: content {
  type: ANALYTICS
  name: "q"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "43b80d86-c743-4b57-a8c7-96d0e2e9d729"
2025-11-11T14:15:36.972336Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471300149523958:2165]
2025-11-11T14:15:36.972356Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:253: Create rate limiter resource for cloud with limit 100000ms
2025-11-11T14:15:36.972388Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create rate limiter resource "mock_cloud" actor
2025-11-11T14:15:36.972393Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud"
2025-11-11T14:15:36.980789Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created rate limiter resource "mock_cloud"
2025-11-11T14:15:36.980802Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create rate limiter resource "mock_cloud": 
2025-11-11T14:15:36.980839Z :YQ_CONTROL_PLANE_PROXY DEBUG: request_actor.h:277: Create response from rate limiter service. Success: 1
2025-11-11T14:15:36.980930Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:226: CreateQueryRequest: {content {
  type: ANALYTICS
  name: "q"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "43b80d86-c743-4b57-a8c7-96d0e2e9d729"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:36.990449Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-11-11T14:15:36.990539Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=0/100 NOTIFY CHANGE
2025-11-11T14:15:37.099954Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: CreateQueryRequest - CreateQueryResult: {query_id: "ptqudslmrtndheehsf29" } SUCCESS
2025-11-11T14:15:37.109213Z :TICKET_PARSER DEBUG: ticket_parser_impl.h:1828: Ticket **** (B6C6F477) (ipv6:[::1]:43362) has now valid token of root@builtin
2025-11-11T14:15:37.109301Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:37.109349Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471304444491259:2169]
2025-11-11T14:15:37.109364Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:37.109378Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:37.109440Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471304444491260:2170]
2025-11-11T14:15:37.109454Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:37.109467Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:37.109477Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471304444491261:2171]
2025-11-11T14:15:37.109530Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrtndheehsf29"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:37.146479Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrtndheehsf29" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870536 nanos: 980865000 } modified_at { seconds: 1762870536 nanos: 980865000 } revision: 1 } execute_mode: RUN status: STARTING last_job_query_revision: 1 last_job_id: "ptjudslmrtndg7fj5rv5-ptqudslmrtndheehsf29" started_by: "root@builtin" submitted_at { seconds: 1762870536 nanos: 980865000 } } content { type: ANALYTICS name: "q" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "SELECT 42;" syntax: YQL_V1 } } } SUCCESS
2025-11-11T14:15:37.202610Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:37.202638Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-11-11T14:15:37.202677Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-11-11T14:15:37.202695Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 0
2025-11-11T14:15:37.230302Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:15:37.230876Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2062"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:15:37.309719Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:463: Task (Query): ptqudslmrtndheehsf29 RetryRate: 0 RetryCounter: 0 At: 2025-11-11T14:15:37.057988Z
2025-11-11T14:15:37.414843Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {tasks { query_id { value: "ptqudslmrtndheehsf29" } job_id { value: "ptjudslmrtndg7fj5rv5" } generation: 1 text: "SELECT 42;" 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: "q" deadline { seconds: 1762956937 nanos: 359335000 } 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: 1762870536 nanos: 980865000 } } } SUCCESS
2025-11-11T14:15:37.414891Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:15:37.415354Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:37.415366Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 1
2025-11-11T14:15:37.415389Z :FQ_PENDING_FETCHER DEBUG: pending_fetcher.cpp:361: NewTask: Scope: yandexcloud://my_folder Id: ptqudslmrtndheehsf29 UserId: root@builtin AuthToken: **** (B6C6F477)
2025-11-11T14:15:37.415508Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:375: QueryId: ptqudslmrtndheehsf29 Start run actor. Compute state: STARTING
2025-11-11T14:15:37.415514Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:469: QueryId: ptqudslmrtndheehsf29 FillConnections
2025-11-11T14:15:37.415534Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:2333: QueryId: ptqudslmrtndheehsf29 Run actors params: { QueryId: ptqudslmrtndheehsf29 CloudId: mock_cloud UserId: root@builtin Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 PreviousQueryRevision: 1 Connections: 0 Bindings: 0 AccountIdSignatures: 0 QueryType: ANALYTICS ExecuteMode: RUN ResultId: ptrudslmrta58061b6np StateLoadMode: EMPTY StreamingDisposition: {  } Status: STARTING DqGraphs: 0 DqGraphIndex: 0 Resource.TopicConsumers: 0 }
2025-11-11T14:15:37.415536Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2063, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:37.415556Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:571: QueryId: ptqudslmrtndheehsf29 Start rate limiter resource creator
2025-11-11T14:15:37.415570Z :FQ_PINGER TRACE: pinger.cpp:171: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Start Pinger
2025-11-11T14:15:37.415592Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward ping request: { started_at { seconds: 1762870537 nanos: 415000000 } }
2025-11-11T14:15:37.415600Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward request Private::PingTask
2025-11-11T14:15:37.415613Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward ping request: { status: RUNNING resources { rate_limiter: PREPARE compilation: PREPARE } }
2025-11-11T14:15:37.415900Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2063, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:15:37.415943Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2063"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:15:37.416034Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Request CP::PingTask with size: 129 bytes
2025-11-11T14:15:37.416105Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2062"
query_id {
  value: "ptqudslmrtndheehsf29"
}
scope: "yandexcloud://my_folder"
started_at {
  seconds: 1762870537
  nanos: 415000000
}
deadline {
  seconds: 1762956937
  nanos: 359335000
}
tenant: "/default"
}
2025-11-11T14:15:37.416159Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:78: PrivateCreateRateLimiterResource - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Request CP::CreateRateLimiterResource with size: 97 bytes
2025-11-11T14:15:37.416193Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: CreateRateLimiterResourceRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2062"
query_id {
  value: "ptqudslmrtndheehsf29"
}
scope: "yandexcloud://my_folder"
tenant: "/default"
} 
2025-11-11T14:15:37.418329Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-11-11T14:15:37.418356Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2063, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:15:37.418612Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:37.418621Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-11-11T14:15:37.453347Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: CreateRateLimiterResourceRequest. Got response from database: SUCCESS
2025-11-11T14:15:37.453491Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29" actor
2025-11-11T14:15:37.453504Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29"
2025-11-11T14:15:37.454439Z :YQ_RATE_LIMITER DEBUG: schema.cpp:261: Trying to recursively create rate limiter resource "mock_cloud/my_folder"
2025-11-11T14:15:37.454450Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder"
2025-11-11T14:15:37.462000Z :YQ_RATE_LIMITER DEBUG: schema.cpp:244: Successfully created rate limiter resource "mock_cloud/my_folder"
2025-11-11T14:15:37.462012Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29"
2025-11-11T14:15:37.463747Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29"
2025-11-11T14:15:37.463760Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29": 
2025-11-11T14:15:37.463801Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:180: Got create response from rate limiter service
2025-11-11T14:15:37.463829Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:102: PrivateCreateRateLimiterResource - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Got CP::CreateRateLimiterResourceResponse
2025-11-11T14:15:37.464169Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1477: QueryId: ptqudslmrtndheehsf29 Rate limiter resource creation finished. Success: 1
2025-11-11T14:15:37.464195Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1966: QueryId: ptqudslmrtndheehsf29 Compiling query ...
2025-11-11T14:15:37.464251Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward ping request: { status: RUNNING resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter" } }
2025-11-11T14:15:37.532820Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.532 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_facade.cpp:899: Execution of [ParseSql] took 67.5ms
2025-11-11T14:15:37.533248Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.533 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_facade.cpp:940: Execution of [Compile] took 388us
2025-11-11T14:15:37.533387Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.533 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [DQ] yql_dq_provider.cpp:109: OpenSession ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud
2025-11-11T14:15:37.533407Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.533 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [DQ] yql_dq_provider.cpp:112: OpenSession ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud complete in 0
2025-11-11T14:15:37.533507Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.533 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_optimize.cpp:671: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [ExpandApply] took 20us
2025-11-11T14:15:37.533608Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.533 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [core eval] yql_eval_expr.cpp:421: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} EvaluateExpression - start
2025-11-11T14:15:37.533755Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.533 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [core eval] yql_eval_expr.cpp:1204: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} EvaluateExpression - finish
2025-11-11T14:15:37.533948Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.533 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [PQ] yql_pq_helpers.cpp:100: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Ids to resolve: 0
2025-11-11T14:15:37.534060Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.534 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [RESULT] yql_result_provider.cpp:1415: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} RewriteIO
2025-11-11T14:15:37.534670Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.534 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [core] type_ann_expr.cpp:159: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Repeated callable stats:
RemovePrefixMembers=1
TypeOf=1
PersistableRepr=1
OrderedSqlProject=1
SqlProjectItem=1
ResWrite!=1

2025-11-11T14:15:37.534684Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.534 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 604us
2025-11-11T14:15:37.534744Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.534 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 24us
2025-11-11T14:15:37.534753Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.534 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 1us
2025-11-11T14:15:37.534800Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.534 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 37us
2025-11-11T14:15:37.534828Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.534 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:37.534837Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.534 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:37.534864Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.534 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 18us
2025-11-11T14:15:37.534879Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.534 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:638: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [UpdateCompletness] took 8us
2025-11-11T14:15:37.534916Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.534 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:651: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [EliminateCommonSubExpressions] took 28us
2025-11-11T14:15:37.534971Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.534 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core] yql_out_transformers.cpp:62: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} OptimizedExpr:
(
(let $1 (Configure! world (DataSource '"config") '"DqEngine" '"force"))
(let $2 (DataSink 'result))
(let $3 '('('type) '('autoref) '('columns '('"column0"))))
(let $4 (ResWrite! $1 $2 (Key) (Unordered (OrderedSqlProject (AsList (AsStruct)) '((SqlProjectItem (ListType (StructType)) '"column0" (lambda '($5) (Int32 '"42")) '())))) $3))
(return (Commit! $4 $2))
)

2025-11-11T14:15:37.535145Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [core] yql_co_simple1.cpp:6780: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Expand OrderedSqlProject
2025-11-11T14:15:37.535208Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:37.535266Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 48us
2025-11-11T14:15:37.535287Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 11us
2025-11-11T14:15:37.535315Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:37.535323Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 1us
2025-11-11T14:15:37.535353Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 21us
2025-11-11T14:15:37.535368Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:638: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [UpdateCompletness] took 6us
2025-11-11T14:15:37.535402Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:651: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [EliminateCommonSubExpressions] took 25us
2025-11-11T14:15:37.535448Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core] yql_out_transformers.cpp:62: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} OptimizedExpr:
(
(let $1 (Configure! world (DataSource '"config") '"DqEngine" '"force"))
(let $2 (DataSink 'result))
(let $3 '('('type) '('autoref) '('columns '('"column0"))))
(let $4 (ResWrite! $1 $2 (Key) (Unordered (OrderedFlatMap (AsList (AsStruct)) (lambda '($5) (AsList (FlattenMembers '('"" (AsStruct '('"column0" (Int32 '"42"))))))))) $3))
(return (Commit! $4 $2))
)

2025-11-11T14:15:37.535475Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [core] yql_opt_utils.cpp:896: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Enumerate struct literal for FlattenMembers
2025-11-11T14:15:37.535525Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:37.535563Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 29us
2025-11-11T14:15:37.535580Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 8us
2025-11-11T14:15:37.535606Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:37.535614Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 1us
2025-11-11T14:15:37.535636Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 13us
2025-11-11T14:15:37.535649Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:638: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [UpdateCompletness] took 5us
2025-11-11T14:15:37.535678Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:651: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [EliminateCommonSubExpressions] took 21us
2025-11-11T14:15:37.535718Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core] yql_out_transformers.cpp:62: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} OptimizedExpr:
(
(let $1 (Configure! world (DataSource '"config") '"DqEngine" '"force"))
(let $2 (DataSink 'result))
(let $3 '('('type) '('autoref) '('columns '('"column0"))))
(let $4 (ResWrite! $1 $2 (Key) (Unordered (OrderedFlatMap (AsList (AsStruct)) (lambda '($5) (AsList (AsStruct '('"column0" (Int32 '"42"))))))) $3))
(return (Commit! $4 $2))
)

2025-11-11T14:15:37.535756Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [core] yql_co_simple1.cpp:2115: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Fuse OrderedFlatMap over AsList
2025-11-11T14:15:37.535796Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:37.535817Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 14us
2025-11-11T14:15:37.535830Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 6us
2025-11-11T14:15:37.535840Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:638: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [UpdateCompletness] took 4us
2025-11-11T14:15:37.535863Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:651: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [EliminateCommonSubExpressions] took 16us
2025-11-11T14:15:37.535890Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core] yql_out_transformers.cpp:62: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} OptimizedExpr:
(
(let $1 (Configure! world (DataSource '"config") '"DqEngine" '"force"))
(let $2 (DataSink 'result))
(let $3 '('('type) '('autoref) '('columns '('"column0"))))
(let $4 (ResWrite! $1 $2 (Key) (Unordered (AsList (AsStruct '('"column0" (Int32 '"42"))))) $3))
(return (Commit! $4 $2))
)

2025-11-11T14:15:37.535906Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [core] yql_co_simple1.cpp:6497: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Drop Unordered over AsList
2025-11-11T14:15:37.535933Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:37.535949Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 9us
2025-11-11T14:15:37.535960Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 4us
2025-11-11T14:15:37.535969Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:638: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [UpdateCompletness] took 4us
2025-11-11T14:15:37.535989Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.535 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:651: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [EliminateCommonSubExpressions] took 13us
2025-11-11T14:15:37.536013Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.536 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core] yql_out_transformers.cpp:62: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} OptimizedExpr:
(
(let $1 (Configure! world (DataSource '"config") '"DqEngine" '"force"))
(let $2 (DataSink 'result))
(let $3 '('('type) '('autoref) '('columns '('"column0"))))
(let $4 (ResWrite! $1 $2 (Key) (AsList (AsStruct '('"column0" (Int32 '"42")))) $3))
(return (Commit! $4 $2))
)

2025-11-11T14:15:37.536733Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.536 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core dq] dq_opt_phy_finalizing.cpp:488: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} DqReplicateStageMultiOutput: start traverse node #209100, Commit!
2025-11-11T14:15:37.536797Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.536 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [RESULT] yql_result_provider.cpp:801: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} ResFill
2025-11-11T14:15:37.536838Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.536 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:37.536870Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.536 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 24us
2025-11-11T14:15:37.536889Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.536 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 10us
2025-11-11T14:15:37.536901Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.536 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:638: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [UpdateCompletness] took 5us
2025-11-11T14:15:37.536925Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.536 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:651: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution of [EliminateCommonSubExpressions] took 18us
2025-11-11T14:15:37.536961Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.536 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core] yql_out_transformers.cpp:62: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} OptimizedExpr:
(
(let $1 (Configure! world (DataSource '"config") '"DqEngine" '"force"))
(let $2 (DataSink 'result))
(let $3 '('('type) '('autoref) '('columns '('"column0"))))
(let $4 (ResFill! $1 $2 (Key) (AsList (AsStruct '('"column0" (Int32 '"42")))) $3 '"dq"))
(return (Commit! $4 $2))
)

2025-11-11T14:15:37.537108Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core dq] dq_opt_phy_finalizing.cpp:488: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} DqReplicateStageMultiOutput: start traverse node #209104, Commit!
2025-11-11T14:15:37.537181Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:61: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Begin, root #209104
2025-11-11T14:15:37.537189Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:74: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Collect unused nodes for root #209104, status: Ok
2025-11-11T14:15:37.537197Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:411: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} {0}, callable #209104 <Commit!>
2025-11-11T14:15:37.537205Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:411: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} {1}, callable #209103 <ResFill!>
2025-11-11T14:15:37.537217Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:411: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} {2}, callable #208965 <Configure!>
2025-11-11T14:15:37.537226Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:411: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} {2}, callable #208965 <Configure!>
2025-11-11T14:15:37.537235Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:630: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Node #208965<Configure!> finished execution
2025-11-11T14:15:37.537243Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:647: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Node #208965<Configure!> created 0 trackable nodes: 
2025-11-11T14:15:37.537251Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:411: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} {1}, callable #209103 <ResFill!>
2025-11-11T14:15:37.537293Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [DQ] yql_dq_exectransformer.cpp:890: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} Executing Result (UniqueId=209113)
2025-11-11T14:15:37.537386Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [core] type_ann_expr.cpp:159: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} Repeated callable stats:
ToStream=1

2025-11-11T14:15:37.537396Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} Execution of [TypeAnnotationTransformer::DoTransform] took 25us
2025-11-11T14:15:37.537405Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} Execution of [TypeAnnotationTransformer::DoTransform] took 1us
2025-11-11T14:15:37.537434Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} Execution of [ConstraintTransformer::DoTransform] took 21us
2025-11-11T14:15:37.537444Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:638: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} Execution of [UpdateCompletness] took 2us
2025-11-11T14:15:37.537459Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:651: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} Execution of [EliminateCommonSubExpressionsForSubGraph] took 7us
2025-11-11T14:15:37.537478Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.537 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core peephole] yql_out_transformers.cpp:62: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} PeepHoleOpt:
(
(return (Iterator (AsList (AsStruct '('"column0" (Int32 '"42"))))))
)

2025-11-11T14:15:37.587027Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870557 nanos: 521000000 } } SUCCESS
2025-11-11T14:15:37.587124Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Got CP::PingTaskResponse
2025-11-11T14:15:37.587447Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Ping response success: { expired_at { seconds: 1762870557 nanos: 521000000 } }
2025-11-11T14:15:37.587464Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward request Private::PingTask
2025-11-11T14:15:37.587488Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudslmrtndheehsf29 Forward ping response. Success: 1. Cookie: 2
2025-11-11T14:15:37.589644Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Request CP::PingTask with size: 123 bytes
2025-11-11T14:15:37.589729Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2062"
query_id {
  value: "ptqudslmrtndheehsf29"
}
status: RUNNING
resources {
  rate_limiter: PREPARE
  compilation: PREPARE
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956937
  nanos: 359335000
}
tenant: "/default"
}
2025-11-11T14:15:37.600906Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870557 nanos: 595000000 } } SUCCESS
2025-11-11T14:15:37.600999Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Got CP::PingTaskResponse
2025-11-11T14:15:37.611163Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Ping response success: { expired_at { seconds: 1762870557 nanos: 595000000 } }
2025-11-11T14:15:37.611185Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward request Private::PingTask
2025-11-11T14:15:37.611218Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudslmrtndheehsf29 Forward ping response. Success: 1. Cookie: 0
2025-11-11T14:15:37.611701Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Request CP::PingTask with size: 192 bytes
2025-11-11T14:15:37.611805Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2062"
query_id {
  value: "ptqudslmrtndheehsf29"
}
status: RUNNING
resources {
  rate_limiter: READY
  compilation: PREPARE
  rate_limiter_path: "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956937
  nanos: 359335000
}
tenant: "/default"
}
2025-11-11T14:15:37.625837Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870557 nanos: 617000000 } } SUCCESS
2025-11-11T14:15:37.625903Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Got CP::PingTaskResponse
2025-11-11T14:15:37.626163Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Ping response success: { expired_at { seconds: 1762870557 nanos: 617000000 } }
2025-11-11T14:15:37.626181Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudslmrtndheehsf29 Forward ping response. Success: 1. Cookie: 0
2025-11-11T14:15:37.633776Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.633 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core dq] dq_opt_phy_finalizing.cpp:488: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} DqReplicateStageMultiOutput: start traverse node #209115, Iterator
2025-11-11T14:15:37.633830Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.633 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core dq] dq_opt_build.cpp:235: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} [DQ/Build/TransformConsumers] (
(return (Iterator (AsList (AsStruct '('"column0" (Int32 '"42"))))))
)

2025-11-11T14:15:37.633852Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.633 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core dq] dq_opt_build.cpp:325: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} [DQ/Build/TransformPhysical] (
(return (Iterator (AsList (AsStruct '('"column0" (Int32 '"42"))))))
)

2025-11-11T14:15:37.634019Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.634 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] type_ann_expr.cpp:48: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} Execution of [TypeAnnotationTransformer::DoTransform] took 5us
2025-11-11T14:15:37.634036Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.634 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} Execution of [ConstraintTransformer::DoTransform] took 3us
2025-11-11T14:15:37.634047Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.634 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:638: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} Execution of [UpdateCompletness] took 3us
2025-11-11T14:15:37.634065Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.634 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_expr_csee.cpp:651: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} Execution of [EliminateCommonSubExpressionsForSubGraph] took 11us
2025-11-11T14:15:37.634083Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.634 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core peephole] yql_out_transformers.cpp:62: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} PeepHoleOpt:
(
(return (Iterator (AsList (AsStruct '('"column0" (Int32 '"42"))))))
)

2025-11-11T14:15:37.634186Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.634 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [DQ] yql_dq_exectransformer.cpp:2143: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud/#209103/#209113} After PeepHole
(
(return (Iterator (AsList (AsStruct '('"column0" (Int32 '"42"))))))
)

2025-11-11T14:15:37.634794Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:928: QueryId: ptqudslmrtndheehsf29 Graph (execution) with tasks: 1
2025-11-11T14:15:37.634831Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.634 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:519: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Register async execution for node #209103
2025-11-11T14:15:37.634852Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.634 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:89: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Finish, output #209104, status: Async
2025-11-11T14:15:37.634915Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.634 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:135: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Completed async execution for node #209103
2025-11-11T14:15:37.634922Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.634 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [DQ] yql_dq_exectransformer.cpp:1083: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud WrapFutureCallback
2025-11-11T14:15:37.634926Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.634 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [DQ] yql_dq_exectransformer.cpp:1086: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Execution Result complete, duration: 0.097627s
2025-11-11T14:15:37.634991Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.634 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:155: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} State is ExecutionComplete after apply async changes for node #209103
2025-11-11T14:15:37.634997Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.634 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:61: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Begin, root #209104
2025-11-11T14:15:37.635003Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.634 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:74: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Collect unused nodes for root #209104, status: Ok
2025-11-11T14:15:37.635008Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.635 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:411: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} {0}, callable #209104 <Commit!>
2025-11-11T14:15:37.635019Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.635 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:630: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Node #209104<Commit!> finished execution
2025-11-11T14:15:37.635031Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.635 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:647: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Node #209104<Commit!> created 0 trackable nodes: 
2025-11-11T14:15:37.635036Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.635 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:89: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Finish, output #209104, status: Ok
2025-11-11T14:15:37.635040Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.635 INFO  ydbd(pid=919645, tid=0x00007F980D24B640) [core exec] yql_execution.cpp:95: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Creating finalizing transformer, output #209104
2025-11-11T14:15:37.635161Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:911: QueryId: ptqudslmrtndheehsf29 Overall dq tasks: 1
2025-11-11T14:15:37.635315Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:758: QueryId: ptqudslmrtndheehsf29 Graph 0
2025-11-11T14:15:37.635384Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward ping request: { ast: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (DataSink \'result))\n(let $3 \'(\'(\'type) \'(\'autoref) \'(\'columns \'(\'\"column0\"))))\n(let $4 (ResFill! $1 $2 (Key) (AsList (AsStruct \'(\'\"column0\" (Int32 \'\"42\")))) $3 \'\"dq\"))\n(return (Commit! $4 $2))\n)\n" plan: "{\"Detailed\":{\"Operations\":[{\"Id\":2,\"Name\":\"ResFill!\"}],\"OperationRoot\":2,\"Providers\":[],\"OperationStats\":{\"ResFill!\":1}},\"Basic\":{\"nodes\":[{\"id\":2,\"level\":1,\"name\":\"ResFill!\",\"type\":\"op\"}],\"links\":[]}}" }
2025-11-11T14:15:37.635387Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward request Private::PingTask
2025-11-11T14:15:37.635422Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward ping request: { result_set_count: 1 result_set_meta { column { name: "column0" type { type_id: INT32 } } } dq_graph: "\022\320\002\010\001\022\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\000\032\004\010\240\215\00628\n4\010\001\030\002 \001*\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\0002\024\n\022\t\001\000\000\000\000\000\000\000\021\000\000\000\000\001\000\000\000X\001R\000:s\n*type.googleapis.com/Yql.DqsProto.TTaskMeta\022E\010\001\022A\022(8d73c3b672aec01e659c446142c7a17d47fb7b86\032\023dq_vanilla_job.lite \002H\001RClocal/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiterZ)mock_cloud/my_folder/ptqudslmrtndheehsf29`\200\200\200\200 \312\001\010/default\"\017\037\000\205\002\203\002\034column0/*\007column02qptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud:\025\n\020AnalyticsHopping\022\0011:\034\n\017_LiteralTimeout\022\t604800000:\032\n\r_TableTimeout\022\t604800000:\037\n\025_AllResultsBytesLimit\022\006100000:\032\n\022_RowsLimitPerWrite\022\0041000:\027\n\022EnableComputeActor\022\0011:\016\n\014WorkerFilter:\031\n\020ComputeActorType\022\005async:\031\n\016WatermarksMode\022\007disable:\037\n\027WatermarksGranularityMs\022\0041000:$\n\034WatermarksLateArrivalDelayMs\022\0045000:\027\n\022EnableChannelStats\022\0011:\020\n\013ExportStats\022\0011be\010\001\022a\037\000\005\205\006\213\000\205\000\204\205\002\203\002\034column0\030Inputs(Parameters\034Program\013\213\000)\251\000?\002\014Arg\000\004)\211\002?\010\206?\006 Iterator\000\006\002?\024\005?\006\003?\004\250\001\001\001\002\001/" }
2025-11-11T14:15:37.636106Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Request CP::PingTask with size: 598 bytes
2025-11-11T14:15:37.636167Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2062"
query_id {
  value: "ptqudslmrtndheehsf29"
}
ast: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (DataSink \'result))\n(let $3 \'(\'(\'type) \'(\'autoref) \'(\'columns \'(\'\"column0\"))))\n(let $4 (ResFill! $1 $2 (Key) (AsList (AsStruct \'(\'\"column0\" (Int32 \'\"42\")))) $3 \'\"dq\"))\n(return (Commit! $4 $2))\n)\n"
plan: "{\"Detailed\":{\"Operations\":[{\"Id\":2,\"Name\":\"ResFill!\"}],\"OperationRoot\":2,\"Providers\":[],\"OperationStats\":{\"ResFill!\":1}},\"Basic\":{\"nodes\":[{\"id\":2,\"level\":1,\"name\":\"ResFill!\",\"type\":\"op\"}],\"links\":[]}}"
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956937
  nanos: 359335000
}
tenant: "/default"
}
2025-11-11T14:15:37.647955Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870557 nanos: 641000000 } } SUCCESS
2025-11-11T14:15:37.648016Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Got CP::PingTaskResponse
2025-11-11T14:15:37.648366Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Ping response success: { expired_at { seconds: 1762870557 nanos: 641000000 } }
2025-11-11T14:15:37.648385Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward request Private::PingTask
2025-11-11T14:15:37.648411Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudslmrtndheehsf29 Forward ping response. Success: 1. Cookie: 0
2025-11-11T14:15:37.648905Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Request CP::PingTask with size: 1070 bytes
2025-11-11T14:15:37.648979Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2062"
query_id {
  value: "ptqudslmrtndheehsf29"
}
result_set_count: 1
result_set_meta {
  column {
    name: "column0"
    type {
      type_id: INT32
    }
  }
}
dq_graph: "\022\320\002\010\001\022\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\000\032\004\010\240\215\00628\n4\010\001\030\002 \001*\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\0002\024\n\022\t\001\000\000\000\000\000\000\000\021\000\000\000\000\001\000\000\000X\001R\000:s\n*type.googleapis.com/Yql.DqsProto.TTaskMeta\022E\010\001\022A\022(8d73c3b672aec01e659c446142c7a17d47fb7b86\032\023dq_vanilla_job.lite \002H\001RClocal/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiterZ)mock_cloud/my_folder/ptqudslmrtndheehsf29`\200\200\200\200 \312\001\010/default\"\017\037\000\205\002\203\002\034column0/*\007column02qptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud:\025\n\020AnalyticsHopping\022\0011:\034\n\017_LiteralTimeout\022\t604800000:\032\n\r_TableTimeout\022\t604800000:\037\n\025_AllResultsBytesLimit\022\006100000:\032\n\022_RowsLimitPerWrite\022\0041000:\027\n\022EnableComputeActor\022\0011:\016\n\014WorkerFilter:\031\n\020ComputeActorType\022\005async:\031\n\016WatermarksMode\022\007disable:\037\n\027WatermarksGranularityMs\022\0041000:$\n\034WatermarksLateArrivalDelayMs\022\0045000:\027\n\022EnableChannelStats\022\0011:\020\n\013ExportStats\022\0011be\010\001\022a\037\000\005\205\006\213\000\205\000\204\205\002\203\002\034column0\030Inputs(Parameters\034Program\013\213\000)\251\000?\002\014Arg\000\004)\211\002?\010\206?\006 Iterator\000\006\002?\024\005?\006\003?\004\250\001\001\001\002\001/"
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956937
  nanos: 359335000
}
tenant: "/default"
}
2025-11-11T14:15:37.650351Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:37.650410Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471304444491296:2205]
2025-11-11T14:15:37.650439Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:37.650489Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:37.650551Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471304444491297:2206]
2025-11-11T14:15:37.650573Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:37.650595Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:37.650607Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471304444491298:2207]
2025-11-11T14:15:37.650630Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrtndheehsf29"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:37.652639Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrtndheehsf29" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870536 nanos: 980865000 } modified_at { seconds: 1762870536 nanos: 980865000 } revision: 1 } started_at { seconds: 1762870537 nanos: 415000000 } execute_mode: RUN status: RUNNING last_job_query_revision: 1 last_job_id: "ptjudslmrtndg7fj5rv5-ptqudslmrtndheehsf29" started_by: "root@builtin" submitted_at { seconds: 1762870536 nanos: 980865000 } } content { type: ANALYTICS name: "q" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "SELECT 42;" syntax: YQL_V1 } plan { json: "{\"Detailed\":{\"Operations\":[{\"Id\":2,\"Name\":\"ResFill!\"}],\"OperationRoot\":2,\"Providers\":[],\"OperationStats\":{\"ResFill!\":1}},\"Basic\":{\"nodes\":[{\"id\":2,\"level\":1,\"name\":\"ResFill!\",\"type\":\"op\"}],\"links\":[]}}" } ast { data: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (DataSink \'result))\n(let $3 \'(\'(\'type) \'(\'autoref) \'(\'columns \'(\'\"column0\"))))\n(let $4 (ResFill! $1 $2 (Key) (AsList (AsStruct \'(\'\"column0\" (Int32 \'\"42\")))) $3 \'\"dq\"))\n(return (Commit! $4 $2))\n)\n" } } } SUCCESS
2025-11-11T14:15:37.661786Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870557 nanos: 653000000 } } SUCCESS
2025-11-11T14:15:37.661832Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Got CP::PingTaskResponse
2025-11-11T14:15:37.662147Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Ping response success: { expired_at { seconds: 1762870557 nanos: 653000000 } }
2025-11-11T14:15:37.662181Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudslmrtndheehsf29 Forward ping response. Success: 1. Cookie: 1
2025-11-11T14:15:37.662203Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:911: QueryId: ptqudslmrtndheehsf29 Overall dq tasks: 1
2025-11-11T14:15:37.662265Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward ping request: { owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2062" query_id { value: "ptqudslmrtndheehsf29" } status: RUNNING result_set_count: 1 result_set_meta { column { name: "column0" type { type_id: INT32 } } } resources { rate_limiter: READY compilation: READY topic_consumers_state: NOT_NEEDED rate_limiter_path: "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter" } scope: "yandexcloud://my_folder" }
2025-11-11T14:15:37.662272Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward request Private::PingTask
2025-11-11T14:15:37.662424Z :FQ_RESULT_WRITER INFO: result_writer.cpp:62: TraceId: ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud Bootstrap
2025-11-11T14:15:37.662452Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.662 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [DQ] task_controller_impl.h:83: _AllResultsBytesLimit = 100000
2025-11-11T14:15:37.662459Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.662 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [DQ] task_controller_impl.h:86: _RowsLimitPerWrite = 1000
2025-11-11T14:15:37.662524Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1653: QueryId: ptqudslmrtndheehsf29 Executer: [1:7571471304444491300:2209], Controller: [1:7571471304444491302:2211], ResultIdActor: [1:7571471304444491301:2210]
2025-11-11T14:15:37.662555Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.662 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] executer_actor.cpp:140: {ptqudslmrtndheehsf29} TDqExecuter::OnGraph
2025-11-11T14:15:37.662574Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.662 INFO  ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] executer_actor.cpp:157: {ptqudslmrtndheehsf29} Trying to allocate 1 workers [EnableComputeActor=1]
2025-11-11T14:15:37.662663Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.662 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] executer_actor.cpp:247: {ptqudslmrtndheehsf29} Dq timeouts are set to: 0.000000s (global), 600.000000s (workers allocation fail), 30.000000s (workers allocation warn) 
2025-11-11T14:15:37.662718Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Request CP::PingTask with size: 213 bytes
2025-11-11T14:15:37.662820Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2062"
query_id {
  value: "ptqudslmrtndheehsf29"
}
status: RUNNING
result_set_count: 1
result_set_meta {
  column {
    name: "column0"
    type {
      type_id: INT32
    }
  }
}
resources {
  rate_limiter: READY
  compilation: READY
  topic_consumers_state: NOT_NEEDED
  rate_limiter_path: "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956937
  nanos: 359335000
}
tenant: "/default"
}
2025-11-11T14:15:37.663444Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:125: TEvAllocateWorkersResponse Nodes {
  ResourceId: 4294967297
  Worker {
    NodeId: 1
    Guid: "f844ff72-449ac1af-3fe22bb4-ffb771e,ghrun-vb3yoermsa"
  }
}
2025-11-11T14:15:37.663501Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.663 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] resource_allocator.cpp:141: {ptqudslmrtndheehsf29/[1:7571471304444491303:2212]} TEvAllocateWorkersResponse 1
2025-11-11T14:15:37.663516Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.663 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] resource_allocator.cpp:106: {ptqudslmrtndheehsf29/[1:7571471304444491303:2212]} RequestActorIdsFromNodes 1
2025-11-11T14:15:37.663523Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.663 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] resource_allocator.cpp:115: {ptqudslmrtndheehsf29/[1:7571471304444491303:2212]} RequestActorIdsFromNodes 1 4294967297
2025-11-11T14:15:37.663529Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.663 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] resource_allocator.cpp:119: {ptqudslmrtndheehsf29/[1:7571471304444491303:2212]} RequestedNode: 1
2025-11-11T14:15:37.663556Z :YQL_PROXY WARN: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.663 WARN  ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] resource_allocator.cpp:259: {ptqudslmrtndheehsf29/[1:7571471304444491303:2212]} Send TEvAllocateWorkersRequest to Id:f844ff72-449ac1af-3fe22bb4-ffb771e,ghrun-vb3yoermsa,NodeId:1,
2025-11-11T14:15:37.663582Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.663 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] local_worker_manager.cpp:316: {ptqudslmrtndheehsf29} TLocalWorkerManager::TEvAllocateWorkersRequest 281479271677953
2025-11-11T14:15:37.663620Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.663 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] local_worker_manager.cpp:376: {ptqudslmrtndheehsf29} Create compute actor: async
2025-11-11T14:15:37.663840Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:134: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Start compute actor [1:7571471304444491307:2216], task: 1
2025-11-11T14:15:37.663871Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:113: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Use CPU quota: 1. Rate limiter resource: { "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter", "mock_cloud/my_folder/ptqudslmrtndheehsf29" }
2025-11-11T14:15:37.663904Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.663 DEBUG ydbd(pid=919645, tid=0x00007F980C249640) [DQ] executer_actor.cpp:358: {ptqudslmrtndheehsf29} TDqExecuter::TEvAllocateWorkersResponse
2025-11-11T14:15:37.663920Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.663 DEBUG ydbd(pid=919645, tid=0x00007F980C249640) [DQ] executer_actor.cpp:384: {ptqudslmrtndheehsf29} Allocated resource 4294967297
2025-11-11T14:15:37.663927Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.663 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] tasks_runner_local.cpp:267: {TODO/1} Build task: 1
2025-11-11T14:15:37.663955Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.663 DEBUG ydbd(pid=919645, tid=0x00007F980C249640) [DQ] executer_actor.cpp:401: {ptqudslmrtndheehsf29} WorkerInfo: Id:f844ff72-449ac1af-3fe22bb4-ffb771e,ghrun-vb3yoermsa,NodeId:1,StageId:1
2025-11-11T14:15:37.663968Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.663 DEBUG ydbd(pid=919645, tid=0x00007F980C249640) [DQ] executer_actor.cpp:402: {ptqudslmrtndheehsf29} TaskInfo: 0/1
2025-11-11T14:15:37.663976Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.663 DEBUG ydbd(pid=919645, tid=0x00007F980C249640) [DQ] executer_actor.cpp:404: {ptqudslmrtndheehsf29}  ObjectId: 8d73c3b672aec01e659c446142c7a17d47fb7b86, dq_vanilla_job.lite, 
2025-11-11T14:15:37.663992Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.663 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] tasks_runner_local.cpp:267: {TODO/1} task: 1, program size: 10, llvm: ``.
2025-11-11T14:15:37.664001Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.663 INFO  ydbd(pid=919645, tid=0x00007F980C249640) [DQ] executer_actor.cpp:415: {ptqudslmrtndheehsf29} 1 workers allocated
2025-11-11T14:15:37.664113Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud 2025-11-11 14:15:37.664 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [DQ] task_controller_impl.h:271: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud}  [1:7571471304444491302:2211] ExportStats Summary
2025-11-11T14:15:37.664146Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud 2025-11-11 14:15:37.664 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [DQ] task_controller_impl.h:526: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Ready State: [1:7571471304444491302:2211]
2025-11-11T14:15:37.666242Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.666 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] tasks_runner_local.cpp:267: {TODO/1} Build task: 1 takes 2292 us
2025-11-11T14:15:37.666266Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.666 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] tasks_runner_local.cpp:267: {TODO/1} Prepare task: 1
2025-11-11T14:15:37.666282Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.666 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] tasks_runner_local.cpp:267: {TODO/1} Prepare task: 1, takes 10 us
2025-11-11T14:15:37.666319Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1491: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Poll inputs
2025-11-11T14:15:37.666325Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1506: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Poll sources
2025-11-11T14:15:37.666327Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. DoExecuteImpl: 0
2025-11-11T14:15:37.666337Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.666 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] tasks_runner_local.cpp:267: {TODO/1} Run task: 1
2025-11-11T14:15:37.666362Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.666 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] tasks_runner_local.cpp:267: {TODO/1} task1, execution finished, finish consumers
2025-11-11T14:15:37.666369Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.666 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] tasks_runner_local.cpp:267: {TODO/1} channelId: 1. Finish request
2025-11-11T14:15:37.666382Z :KQP_COMPUTE TRACE: dq_compute_memory_quota.h:97: TxId: ptqudslmrtndheehsf29, task: 1. Peak memory usage: 196608
2025-11-11T14:15:37.666393Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. update task runner stats
2025-11-11T14:15:37.666405Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Resume execution, run status: Finished checkpoint: 0 watermark injected: (empty maybe)
2025-11-11T14:15:37.666407Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-11T14:15:37.666409Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:409: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Can not drain channelId: 1, no dst actor id
2025-11-11T14:15:37.666412Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:502: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Continue execution, either output buffers are not empty or not all channels are ready, hasDataToSend: 1, channelsReady: 0
2025-11-11T14:15:37.666436Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud 2025-11-11 14:15:37.666 TRACE ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] task_controller_impl.h:160: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} [1:7571471304444491302:2211] EvState TaskId: 1 State: 2 PingCookie: 0 StatusCode: UNSPECIFIED
2025-11-11T14:15:37.666444Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud 2025-11-11 14:15:37.666 TRACE ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] task_controller_impl.h:201: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud}  [1:7571471304444491302:2211] Executing TaskId: 1
2025-11-11T14:15:37.666460Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud 2025-11-11 14:15:37.666 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] task_controller_impl.h:561: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} Update channels
2025-11-11T14:15:37.667570Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud 2025-11-11 14:15:37.666 TRACE ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] task_controller_impl.h:577: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} 1 Update { Id: 1 SrcTaskId: 2 DstTaskId: 1 SrcEndpoint { ActorId { RawX1: 0 RawX2: 0 } } DstEndpoint { ActorId { RawX1: 7571471304444491301 RawX2: 4503603922340002 } } SrcStageId: 1 }
2025-11-11T14:15:37.667610Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1074: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Received channels info: Update { Id: 1 SrcTaskId: 2 DstTaskId: 1 SrcEndpoint { ActorId { RawX1: 0 RawX2: 0 } } DstEndpoint { ActorId { RawX1: 7571471304444491301 RawX2: 4503603922340002 } } SrcStageId: 1 }
2025-11-11T14:15:37.667614Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1093: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Update output channelId: 1, peer: [1:7571471304444491301:2210]
2025-11-11T14:15:37.667617Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1491: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Poll inputs
2025-11-11T14:15:37.667618Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1506: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Poll sources
2025-11-11T14:15:37.667619Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. DoExecuteImpl: 0
2025-11-11T14:15:37.667637Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.667 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] tasks_runner_local.cpp:267: {TODO/1} Run task: 1
2025-11-11T14:15:37.667650Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.667 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] tasks_runner_local.cpp:267: {TODO/1} task1, execution finished, finish consumers
2025-11-11T14:15:37.667657Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.667 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] tasks_runner_local.cpp:267: {TODO/1} channelId: 1. Finish request
2025-11-11T14:15:37.667670Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. update task runner stats
2025-11-11T14:15:37.667686Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Resume execution, run status: Finished checkpoint: 0 watermark injected: (empty maybe)
2025-11-11T14:15:37.667687Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-11T14:15:37.667691Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. About to drain channelId: 1, hasPeer: 1, peerState:(freeSpace:1000000;inFlightBytes:0;inFlightCount:0;)
2025-11-11T14:15:37.667716Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 375f7e2d-78674bb5-bf909c3d-ca55f206 2025-11-11 14:15:37.667 DEBUG ydbd(pid=919645, tid=0x00007F980EA4E640) [DQ] tasks_runner_local.cpp:267: {TODO/1} channelId: 1. Took 1 rows
2025-11-11T14:15:37.667731Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:566: TxId: ptqudslmrtndheehsf29, task: 1. SendChannelData, channelId: 1, peer: [1:7571471304444491301:2210], chunks: 1, bytes: 3, watermark: 0, checkpoint: 0, seqNo: 1, finished: 1
2025-11-11T14:15:37.667748Z :KQP_COMPUTE DEBUG: dq_compute_actor_channels.cpp:669: TxId: ptqudslmrtndheehsf29, task: 1. Tasks execution finished, waiting for chunk delivery in output channelId: 1, seqNo: [1]
2025-11-11T14:15:37.668281Z :YQL_PRIVATE_PROXY DEBUG: task_result_write.cpp:79: PrivateWriteTask - ResultId: ptrudslmrta58061b6np, RequestId: 0,  Request CP::WriteTaskResult with size: 102 bytes
2025-11-11T14:15:37.668301Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_result_write.cpp:33: WriteResultDataRequest: ptrudslmrta58061b6np 0 0 24 2025-11-12T14:15:37.359335Z
2025-11-11T14:15:37.670047Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870557 nanos: 666000000 } } SUCCESS
2025-11-11T14:15:37.670107Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Got CP::PingTaskResponse
2025-11-11T14:15:37.670341Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Ping response success: { expired_at { seconds: 1762870557 nanos: 666000000 } }
2025-11-11T14:15:37.670366Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudslmrtndheehsf29 Forward ping response. Success: 1. Cookie: 0
2025-11-11T14:15:37.688763Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: WriteResultDataRequest - WriteResultDataResult: {} SUCCESS
2025-11-11T14:15:37.688824Z :YQL_PRIVATE_PROXY DEBUG: task_result_write.cpp:94: PrivateWriteTask - ResultId: ptrudslmrta58061b6np, RequestId: 0,  Got CP::WriteTaskResult Response
2025-11-11T14:15:37.689152Z :FQ_RESULT_WRITER TRACE: result_writer.cpp:175: TraceId: ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud ChannelData, Records: 1 HasError: 0 Size: 3 Rows: 1 FreeSpace: 67108864 Duration: 0.026728s AvgSpeed: 0
2025-11-11T14:15:37.689166Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:179: TxId: ptqudslmrtndheehsf29, task: 1. Received channel data ack for channelId: 1, seqNo: 1, lastSentSeqNo: 1, freeSpace: 67108864, early finish: 0
2025-11-11T14:15:37.689176Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:207: TxId: ptqudslmrtndheehsf29, task: 1. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 1, ackSeqNo: 1
2025-11-11T14:15:37.689178Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:220: TxId: ptqudslmrtndheehsf29, task: 1. Resume compute actor
2025-11-11T14:15:37.689194Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1491: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Poll inputs
2025-11-11T14:15:37.689195Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1506: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Poll sources
2025-11-11T14:15:37.689197Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. DoExecuteImpl: 0
2025-11-11T14:15:37.689266Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. update task runner stats
2025-11-11T14:15:37.689295Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Resume execution, run status: Finished checkpoint: 0 watermark injected: (empty maybe)
2025-11-11T14:15:37.689302Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-11T14:15:37.689305Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:423: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Do not drain channelId: 1, finished
2025-11-11T14:15:37.689309Z :KQP_COMPUTE DEBUG: dq_compute_actor_channels.cpp:674: TxId: ptqudslmrtndheehsf29, task: 1. Tasks execution finished
2025-11-11T14:15:37.689312Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:510: SelfId: [1:7571471304444491307:2216], TxId: ptqudslmrtndheehsf29, task: 1. Ctx: {}. Compute state finished. All channels and sinks finished
2025-11-11T14:15:37.689335Z :KQP_COMPUTE DEBUG: dq_compute_actor_channels.cpp:494: TxId: ptqudslmrtndheehsf29, task: 1. pass away
2025-11-11T14:15:37.689561Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud 2025-11-11 14:15:37.689 TRACE ydbd(pid=919645, tid=0x00007F980C249640) [DQ] task_controller_impl.h:160: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud} [1:7571471304444491302:2211] EvState TaskId: 1 State: 3 PingCookie: 0 StatusCode: SUCCESS
2025-11-11T14:15:37.689575Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud 2025-11-11 14:15:37.689 TRACE ydbd(pid=919645, tid=0x00007F980C249640) [DQ] task_controller_impl.h:174: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud}  [1:7571471304444491302:2211] AddStats 1
2025-11-11T14:15:37.689633Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud 2025-11-11 14:15:37.689 DEBUG ydbd(pid=919645, tid=0x00007F980C249640) [DQ] task_controller_impl.h:212: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud}  [1:7571471304444491302:2211] Finish TaskId: 1. Tasks finished: 1/1
2025-11-11T14:15:37.689814Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud 2025-11-11 14:15:37.689 TRACE ydbd(pid=919645, tid=0x00007F980C249640) [DQ] task_controller_impl.h:271: {ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud}  [1:7571471304444491302:2211] ExportStats Summary
2025-11-11T14:15:37.690172Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.690 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [DQ] executer_actor.cpp:324: {ptqudslmrtndheehsf29} OnGraphFinished
2025-11-11T14:15:37.690191Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.690 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [DQ] executer_actor.cpp:284: {ptqudslmrtndheehsf29} Finish with status=1 issues=
2025-11-11T14:15:37.690391Z :FQ_RESULT_WRITER DEBUG: result_writer.cpp:126: TraceId: ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud Send response to executer
2025-11-11T14:15:37.690416Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:37.690 DEBUG ydbd(pid=919645, tid=0x00007F980D24B640) [DQ] executer_actor.cpp:341: {ptqudslmrtndheehsf29} OnQueryResponse status=1 issuses_size=0
2025-11-11T14:15:37.690445Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1234: QueryId: ptqudslmrtndheehsf29 Query response SUCCESS. Result set index: 0. Issues count: 0. Rows count: 1
2025-11-11T14:15:37.690886Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1827: QueryId: ptqudslmrtndheehsf29 Is about to finish query with status COMPLETED
2025-11-11T14:15:37.690893Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1820: QueryId: ptqudslmrtndheehsf29 Write finalizing status: COMPLETING
2025-11-11T14:15:37.691225Z :FQ_RESULT_WRITER INFO: result_writer.cpp:87: TraceId: ptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud FinishWrite, Records: 1 HasError: 0 Size: 3 Rows: 1 FreeSpace: 67108864 Duration: 0.028807s AvgSpeed: 0 ResultChunks.size(): 0
2025-11-11T14:15:37.691397Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward ping request: { status: COMPLETING }
2025-11-11T14:15:37.691399Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward request Private::PingTask
2025-11-11T14:15:37.691952Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Request CP::PingTask with size: 116 bytes
2025-11-11T14:15:37.692047Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2062"
query_id {
  value: "ptqudslmrtndheehsf29"
}
status: COMPLETING
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956937
  nanos: 359335000
}
tenant: "/default"
}
2025-11-11T14:15:37.708564Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870557 nanos: 698000000 } } SUCCESS
2025-11-11T14:15:37.708620Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Got CP::PingTaskResponse
2025-11-11T14:15:37.709159Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Ping response success: { expired_at { seconds: 1762870557 nanos: 698000000 } }
2025-11-11T14:15:37.709198Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:880: QueryId: ptqudslmrtndheehsf29 Forward ping response. Success: 1. Cookie: 3
2025-11-11T14:15:37.709200Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:887: QueryId: ptqudslmrtndheehsf29 Finalizing status is saved
2025-11-11T14:15:37.709204Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1508: QueryId: ptqudslmrtndheehsf29 Start rate limiter resource deleter
2025-11-11T14:15:37.709738Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:175: PrivateDeleteRateLimiterResource - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Request CP::DeleteRateLimiterResource with size: 97 bytes
2025-11-11T14:15:37.709788Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: DeleteRateLimiterResourceRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2062"
query_id {
  value: "ptqudslmrtndheehsf29"
}
scope: "yandexcloud://my_folder"
tenant: "/default"
} 
2025-11-11T14:15:37.739390Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: DeleteRateLimiterResourceRequest. Got response from database: SUCCESS
2025-11-11T14:15:37.739499Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run delete rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29" actor
2025-11-11T14:15:37.739503Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call delete rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29"
2025-11-11T14:15:37.742154Z :YQ_RATE_LIMITER DEBUG: schema.cpp:179: Successfully deleted rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29"
2025-11-11T14:15:37.742166Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for delete rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29": 
2025-11-11T14:15:37.742192Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:219: Got delete response from rate limiter service
2025-11-11T14:15:37.742211Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:199: PrivateDeleteRateLimiterResource - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Got CP::DeleteRateLimiterResourceResponse
2025-11-11T14:15:37.742973Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1499: QueryId: ptqudslmrtndheehsf29 Rate limiter resource deletion finished. Success: 1. Issues: 
2025-11-11T14:15:37.742985Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1919: QueryId: ptqudslmrtndheehsf29 SendPingAndPassAway, FinalQueryStatus COMPLETED
2025-11-11T14:15:37.743006Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:536: QueryId: ptqudslmrtndheehsf29 PassAway
2025-11-11T14:15:37.743204Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward ping request: { owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2062" query_id { value: "ptqudslmrtndheehsf29" } result_id { value: "ptrudslmrta58061b6np" } status: COMPLETED result_set_count: 1 statistics: "{\"Graph=0\":{\"Actor\":{\"ActorCreateTimeUs\":{\"sum\":\"349us\",\"count\":1,\"avg\":\"349us\",\"max\":\"349us\",\"min\":\"349us\"}},\"AllocateWorkersUs\":{\"sum\":\"1ms\",\"count\":1,\"avg\":\"1ms\",\"max\":\"1ms\",\"min\":\"1ms\"},\"ExecutionTimeUs\":{\"sum\":\"26ms\",\"count\":1,\"avg\":\"26ms\",\"max\":\"26ms\",\"min\":\"26ms\"},\"TaskRunner\":{\"Output=0\":{\"Stage=1\":{\"PopBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"PopChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}},\"Output=Total\":{\"Stage=1\":{\"ChannelCount\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"PopChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"ChannelCount\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"PopChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}},\"Stage=1\":{\"BuildCpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"54us\",\"count\":1,\"avg\":\"54us\",\"max\":\"54us\",\"min\":\"54us\"},\"CpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"FinishTimeMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.68s\",\"max\":\"14:15:37.68s\",\"min\":\"14:15:37.68s\"},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":196608,\"count\":1,\"avg\":196608,\"max\":196608,\"min\":196608},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"OutputBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"OutputRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"ResultBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"ResultRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"BuildCpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"54us\",\"count\":1,\"avg\":\"54us\",\"max\":\"54us\",\"min\":\"54us\"},\"CpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"FinishTimeMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.68s\",\"max\":\"14:15:37.68s\",\"min\":\"14:15:37.68s\"},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":196608,\"count\":1,\"avg\":196608,\"max\":196608,\"min\":196608},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"OutputBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"OutputRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"ResultBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"ResultRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}},\"UniqueWorkers\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}}" result_set_meta { column { name: "column0" type { type_id: INT32 } } rows_count: 1 } status_code: SUCCESS resources { rate_limiter: READY compilation: READY topic_consumers_state: NOT_NEEDED rate_limiter_path: "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter" } scope: "yandexcloud://my_folder" finished_at { seconds: 1762870537 nanos: 690000000 } }
2025-11-11T14:15:37.743215Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Forward request Private::PingTask
2025-11-11T14:15:37.743665Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Request CP::PingTask with size: 5641 bytes
2025-11-11T14:15:37.743780Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2062"
query_id {
  value: "ptqudslmrtndheehsf29"
}
result_id {
  value: "ptrudslmrta58061b6np"
}
status: COMPLETED
result_set_count: 1
statistics: "{\"Graph=0\":{\"Actor\":{\"ActorCreateTimeUs\":{\"sum\":\"349us\",\"count\":1,\"avg\":\"349us\",\"max\":\"349us\",\"min\":\"349us\"}},\"AllocateWorkersUs\":{\"sum\":\"1ms\",\"count\":1,\"avg\":\"1ms\",\"max\":\"1ms\",\"min\":\"1ms\"},\"ExecutionTimeUs\":{\"sum\":\"26ms\",\"count\":1,\"avg\":\"26ms\",\"max\":\"26ms\",\"min\":\"26ms\"},\"TaskRunner\":{\"Output=0\":{\"Stage=1\":{\"PopBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"PopChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}},\"Output=Total\":{\"Stage=1\":{\"ChannelCount\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"PopChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"ChannelCount\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"PopChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.66s\",\"max\":\"14:15:37.66s\",\"min\":\"14:15:37.66s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}},\"Stage=1\":{\"BuildCpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"54us\",\"count\":1,\"avg\":\"54us\",\"max\":\"54us\",\"min\":\"54us\"},\"CpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"FinishTimeMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.68s\",\"max\":\"14:15:37.68s\",\"min\":\"14:15:37.68s\"},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":196608,\"count\":1,\"avg\":196608,\"max\":196608,\"min\":196608},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"OutputBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"OutputRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"ResultBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"ResultRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"BuildCpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"54us\",\"count\":1,\"avg\":\"54us\",\"max\":\"54us\",\"min\":\"54us\"},\"CpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"FinishTimeMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:37.68s\",\"max\":\"14:15:37.68s\",\"min\":\"14:15:37.68s\"},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":196608,\"count\":1,\"avg\":196608,\"max\":196608,\"min\":196608},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"OutputBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"OutputRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"ResultBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"ResultRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}},\"UniqueWorkers\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}}"
result_set_meta {
  column {
    name: "column0"
    type {
      type_id: INT32
    }
  }
  rows_count: 1
}
status_code: SUCCESS
resources {
  rate_limiter: READY
  compilation: READY
  topic_consumers_state: NOT_NEEDED
  rate_limiter_path: "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter"
}
scope: "yandexcloud://my_folder"
finished_at {
  seconds: 1762870537
  nanos: 690000000
}
deadline {
  seconds: 1762956937
  nanos: 359335000
}
tenant: "/default"
}
2025-11-11T14:15:37.817980Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {} SUCCESS
2025-11-11T14:15:37.818015Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062, Got CP::PingTaskResponse
2025-11-11T14:15:37.818351Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Ping response success: {  }
2025-11-11T14:15:37.818375Z :FQ_PINGER DEBUG: pinger.cpp:379: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Query finished
2025-11-11T14:15:37.818378Z :FQ_PINGER TRACE: pinger.cpp:187: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2062 Stop Pinger
2025-11-11T14:15:38.156021Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:38.156059Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471308739458623:2233]
2025-11-11T14:15:38.156074Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:38.156085Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:38.156108Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471308739458624:2234]
2025-11-11T14:15:38.156122Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:38.156131Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:38.156141Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471308739458625:2235]
2025-11-11T14:15:38.156162Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrtndheehsf29"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:38.159578Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrtndheehsf29" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870536 nanos: 980865000 } modified_at { seconds: 1762870536 nanos: 980865000 } revision: 1 } started_at { seconds: 1762870537 nanos: 415000000 } finished_at { seconds: 1762870537 nanos: 690000000 } execute_mode: RUN status: COMPLETED last_job_query_revision: 1 last_job_id: "ptjudslmrtndg7fj5rv5-ptqudslmrtndheehsf29" result_expire_at { seconds: 1762956937 nanos: 359335000 } started_by: "root@builtin" submitted_at { seconds: 1762870536 nanos: 980865000 } } content { type: ANALYTICS name: "q" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "SELECT 42;" syntax: YQL_V1 } plan { json: "{\"Detailed\":{\"Operations\":[{\"Id\":2,\"Name\":\"ResFill!\"}],\"OperationRoot\":2,\"Providers\":[],\"OperationStats\":{\"ResFill!\":1}},\"Basic\":{\"nodes\":[{\"id\":2,\"level\":1,\"name\":\"ResFill!\",\"type\":\"op\"}],\"links\":[]}}" } statistics { json: "{\"Graph=0\":{\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"CpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"OutputBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"OutputRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"ResultBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"ResultRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"MaxMemoryUsage\":{\"sum\":196608,\"count\":1,\"avg\":196608,\"max\":196608,\"min\":196608},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0}}}" } result_set_meta { column { name: "column0" type { type_id: INT32 } } rows_count: 1 } ast { data: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (DataSink \'result))\n(let $3 \'(\'(\'type) \'(\'autoref) \'(\'columns \'(\'\"column0\"))))\n(let $4 (ResFill! $1 $2 (Key) (AsList (AsStruct \'(\'\"column0\" (Int32 \'\"42\")))) $3 \'\"dq\"))\n(return (Commit! $4 $2))\n)\n" } } } SUCCESS
2025-11-11T14:15:38.163134Z :TICKET_PARSER DEBUG: ticket_parser_impl.h:1828: Ticket **** (B6C6F477) (ipv6:[::1]:43362) has now valid token of root@builtin
2025-11-11T14:15:38.163234Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:922: ModifyQueryRequest: query_id: "ptqudslmrtndheehsf29"
content {
  type: ANALYTICS
  name: "q"
  acl {
    visibility: PRIVATE
  }
  text: "blablabla"
}
execute_mode: RUN
state_load_mode: EMPTY
2025-11-11T14:15:38.163265Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471308739458629:2238]
2025-11-11T14:15:38.163282Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:38.163293Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:92: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7571471308739458630:2239]
2025-11-11T14:15:38.163323Z :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:15:38.163333Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:108: Cloud id: mock_cloud Quota count: 8
2025-11-11T14:15:38.163348Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:922: ModifyQueryRequest: query_id: "ptqudslmrtndheehsf29"
content {
  type: ANALYTICS
  name: "q"
  acl {
    visibility: PRIVATE
  }
  text: "blablabla"
}
execute_mode: RUN
state_load_mode: EMPTY
2025-11-11T14:15:38.163385Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471308739458631:2240]
2025-11-11T14:15:38.163425Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:38.163500Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:922: ModifyQueryRequest: query_id: "ptqudslmrtndheehsf29"
content {
  type: ANALYTICS
  name: "q"
  acl {
    visibility: PRIVATE
  }
  text: "blablabla"
}
execute_mode: RUN
state_load_mode: EMPTY
2025-11-11T14:15:38.163532Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:444: Create database bootstrap. CloudId: mock_cloud Scope: yandexcloud://my_folder Actor id: [1:7571471308739458632:2241]
2025-11-11T14:15:38.163555Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:922: ModifyQueryRequest: query_id: "ptqudslmrtndheehsf29"
content {
  type: ANALYTICS
  name: "q"
  acl {
    visibility: PRIVATE
  }
  text: "blablabla"
}
execute_mode: RUN
state_load_mode: EMPTY
2025-11-11T14:15:38.163577Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471308739458633:2242]
2025-11-11T14:15:38.163630Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:812: ModifyQueryRequest: {query_id: "ptqudslmrtndheehsf29"
content {
  type: ANALYTICS
  name: "q"
  acl {
    visibility: PRIVATE
  }
  text: "blablabla"
}
execute_mode: RUN
state_load_mode: EMPTY
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:38.201988Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:617: RowDispatcher: Send ping to [1:7571471300149523897:2111]
2025-11-11T14:15:38.202012Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1161: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-11T14:15:38.202019Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:314: Coordinator: TEvPing received, [1:7571471300149523838:2069]
2025-11-11T14:15:38.202023Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:317: Coordinator: Send TEvPong to [1:7571471300149523838:2069]
2025-11-11T14:15:38.202036Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:623: RowDispatcher: NActors::TEvents::TEvPong
2025-11-11T14:15:38.203305Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2064, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:38.203327Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-11-11T14:15:38.203546Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-11-11T14:15:38.203568Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 0
2025-11-11T14:15:38.205756Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2064, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:15:38.205812Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2064"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:15:38.215078Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-11-11T14:15:38.215151Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2064, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:15:38.221635Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:38.221654Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-11-11T14:15:38.498609Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: ModifyQueryRequest - ModifyQueryResult: {} SUCCESS
2025-11-11T14:15:38.500252Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:38.500286Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471308739458640:2248]
2025-11-11T14:15:38.500306Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:38.500328Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:38.500371Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471308739458641:2249]
2025-11-11T14:15:38.500396Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:38.500414Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:38.500438Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471308739458642:2250]
2025-11-11T14:15:38.500468Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrtndheehsf29"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:38.502833Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrtndheehsf29" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870536 nanos: 980865000 } modified_at { seconds: 1762870538 nanos: 345833000 } revision: 2 } execute_mode: RUN status: STARTING last_job_query_revision: 2 last_job_id: "ptjudslmrsdok0ef1207-ptqudslmrtndheehsf29" started_by: "root@builtin" submitted_at { seconds: 1762870538 nanos: 345833000 } } content { type: ANALYTICS name: "q" acl { visibility: PRIVATE } text: "blablabla" } } } SUCCESS
2025-11-11T14:15:39.004995Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:39.005049Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471313034425942:2253]
2025-11-11T14:15:39.005083Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:39.005105Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:39.005140Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471313034425943:2254]
2025-11-11T14:15:39.005161Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:39.005177Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:39.005188Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471313034425944:2255]
2025-11-11T14:15:39.005217Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrtndheehsf29"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:39.008074Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrtndheehsf29" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870536 nanos: 980865000 } modified_at { seconds: 1762870538 nanos: 345833000 } revision: 2 } execute_mode: RUN status: STARTING last_job_query_revision: 2 last_job_id: "ptjudslmrsdok0ef1207-ptqudslmrtndheehsf29" started_by: "root@builtin" submitted_at { seconds: 1762870538 nanos: 345833000 } } content { type: ANALYTICS name: "q" acl { visibility: PRIVATE } text: "blablabla" } } } SUCCESS
2025-11-11T14:15:39.203478Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:39.203513Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-11-11T14:15:39.203751Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-11-11T14:15:39.203766Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 0
2025-11-11T14:15:39.205907Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:15:39.205976Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2065"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:15:39.214400Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:463: Task (Query): ptqudslmrtndheehsf29 RetryRate: 0 RetryCounter: 0 At: 2025-11-11T14:15:38.345943Z
2025-11-11T14:15:39.224598Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {tasks { query_id { value: "ptqudslmrtndheehsf29" } job_id { value: "ptjudslmrsdok0ef1207" } generation: 2 dq_graph: "\022\320\002\010\001\022\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\000\032\004\010\240\215\00628\n4\010\001\030\002 \001*\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\0002\024\n\022\t\001\000\000\000\000\000\000\000\021\000\000\000\000\001\000\000\000X\001R\000:s\n*type.googleapis.com/Yql.DqsProto.TTaskMeta\022E\010\001\022A\022(8d73c3b672aec01e659c446142c7a17d47fb7b86\032\023dq_vanilla_job.lite \002H\001RClocal/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiterZ)mock_cloud/my_folder/ptqudslmrtndheehsf29`\200\200\200\200 \312\001\010/default\"\017\037\000\205\002\203\002\034column0/*\007column02qptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud:\025\n\020AnalyticsHopping\022\0011:\034\n\017_LiteralTimeout\022\t604800000:\032\n\r_TableTimeout\022\t604800000:\037\n\025_AllResultsBytesLimit\022\006100000:\032\n\022_RowsLimitPerWrite\022\0041000:\027\n\022EnableComputeActor\022\0011:\016\n\014WorkerFilter:\031\n\020ComputeActorType\022\005async:\031\n\016WatermarksMode\022\007disable:\037\n\027WatermarksGranularityMs\022\0041000:$\n\034WatermarksLateArrivalDelayMs\022\0045000:\027\n\022EnableChannelStats\022\0011:\020\n\013ExportStats\022\0011be\010\001\022a\037\000\005\205\006\213\000\205\000\204\205\002\203\002\034column0\030Inputs(Parameters\034Program\013\213\000)\251\000?\002\014Arg\000\004)\211\002?\010\206?\006 Iterator\000\006\002?\024\005?\006\003?\004\250\001\001\001\002\001/" text: "blablabla" 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: "q" deadline { seconds: 1762956939 nanos: 218567000 } disposition { } result_limit: 20971520 execution_limit { seconds: 86400 } request_started_at { } resources { } compute_connection { } result_ttl { seconds: 86400 } request_submitted_at { seconds: 1762870538 nanos: 345833000 } } } SUCCESS
2025-11-11T14:15:39.224651Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:15:39.225094Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:39.225102Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 1
2025-11-11T14:15:39.225115Z :FQ_PENDING_FETCHER DEBUG: pending_fetcher.cpp:361: NewTask: Scope: yandexcloud://my_folder Id: ptqudslmrtndheehsf29 UserId: root@builtin AuthToken: **** (B6C6F477)
2025-11-11T14:15:39.225244Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2066, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:39.225264Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:375: QueryId: ptqudslmrtndheehsf29 Start run actor. Compute state: STARTING
2025-11-11T14:15:39.225266Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:469: QueryId: ptqudslmrtndheehsf29 FillConnections
2025-11-11T14:15:39.225283Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:2333: QueryId: ptqudslmrtndheehsf29 Run actors params: { QueryId: ptqudslmrtndheehsf29 CloudId: mock_cloud UserId: root@builtin Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 PreviousQueryRevision: 2 Connections: 0 Bindings: 0 AccountIdSignatures: 0 QueryType: ANALYTICS ExecuteMode: RUN ResultId: ptrudslmrritu06390f6 StateLoadMode: EMPTY StreamingDisposition: {  } Status: STARTING DqGraphs: 1 DqGraphIndex: 0 Resource.TopicConsumers: 0 }
2025-11-11T14:15:39.225297Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:571: QueryId: ptqudslmrtndheehsf29 Start rate limiter resource creator
2025-11-11T14:15:39.225491Z :FQ_PINGER TRACE: pinger.cpp:171: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Start Pinger
2025-11-11T14:15:39.225511Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Forward ping request: { started_at { seconds: 1762870539 nanos: 225000000 } }
2025-11-11T14:15:39.225516Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Forward request Private::PingTask
2025-11-11T14:15:39.225532Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Forward ping request: { status: RUNNING resources { rate_limiter: PREPARE compilation: PREPARE } }
2025-11-11T14:15:39.229658Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2066, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:15:39.229667Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065, Request CP::PingTask with size: 127 bytes
2025-11-11T14:15:39.229716Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:78: PrivateCreateRateLimiterResource - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065, Request CP::CreateRateLimiterResource with size: 97 bytes
2025-11-11T14:15:39.229736Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2066"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:15:39.229851Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2065"
query_id {
  value: "ptqudslmrtndheehsf29"
}
scope: "yandexcloud://my_folder"
started_at {
  seconds: 1762870539
  nanos: 225000000
}
deadline {
  seconds: 1762956939
  nanos: 218567000
}
tenant: "/default"
}
2025-11-11T14:15:39.229930Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: CreateRateLimiterResourceRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2065"
query_id {
  value: "ptqudslmrtndheehsf29"
}
scope: "yandexcloud://my_folder"
tenant: "/default"
} 
2025-11-11T14:15:39.233146Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-11-11T14:15:39.233203Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2066, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:15:39.233697Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:39.233705Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-11-11T14:15:39.237188Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: CreateRateLimiterResourceRequest. Got response from database: SUCCESS
2025-11-11T14:15:39.237315Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29" actor
2025-11-11T14:15:39.237323Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29"
2025-11-11T14:15:39.239612Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29"
2025-11-11T14:15:39.239625Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29": 
2025-11-11T14:15:39.239663Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:180: Got create response from rate limiter service
2025-11-11T14:15:39.239694Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:102: PrivateCreateRateLimiterResource - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065, Got CP::CreateRateLimiterResourceResponse
2025-11-11T14:15:39.240018Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1477: QueryId: ptqudslmrtndheehsf29 Rate limiter resource creation finished. Success: 1
2025-11-11T14:15:39.240046Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1966: QueryId: ptqudslmrtndheehsf29 Compiling query ...
2025-11-11T14:15:39.240104Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Forward ping request: { status: RUNNING resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter" } }
2025-11-11T14:15:39.240510Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrtndheehsf29 2025-11-11 14:15:39.240 TRACE ydbd(pid=919645, tid=0x00007F980D24B640) [perf] yql_facade.cpp:899: Execution of [ParseSql] took 295us
2025-11-11T14:15:39.240578Z :FQ_RUN_ACTOR WARN: run_actor.cpp:1914: QueryId: ptqudslmrtndheehsf29 ResignQuery, status ABORTED
2025-11-11T14:15:39.240582Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1919: QueryId: ptqudslmrtndheehsf29 SendPingAndPassAway, FinalQueryStatus COMPUTE_STATUS_UNSPECIFIED
2025-11-11T14:15:39.240596Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:536: QueryId: ptqudslmrtndheehsf29 PassAway
2025-11-11T14:15:39.240606Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Forward ping request: {  }
2025-11-11T14:15:39.240675Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Forward ping request: { owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2065" query_id { value: "ptqudslmrtndheehsf29" } 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 } message: "mismatched input \'blablabla\' expecting {\';\', \'(\', \'$\', ALTER, ANALYZE, BACKUP, BATCH, COMMIT, CREATE, DECLARE, DEFINE, DELETE, DISCARD, DO, DROP, EVALUATE, EXPLAIN, EXPORT, FOR, FROM, GRANT, IF, IMPORT, INSERT, PARALLEL, PRAGMA, PROCESS, REDUCE, REPLACE, RESTORE, REVOKE, ROLLBACK, SELECT, SHOW, UPDATE, UPSERT, USE, VALUES}" end_position { row: 1 } severity: 1 } } } status_code: ABORTED resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter" } scope: "yandexcloud://my_folder" }
2025-11-11T14:15:39.294605Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-11-11T14:15:39.295664Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870559 nanos: 237000000 } } SUCCESS
2025-11-11T14:15:39.295692Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065, Got CP::PingTaskResponse
2025-11-11T14:15:39.295968Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Ping response success: { expired_at { seconds: 1762870559 nanos: 237000000 } }
2025-11-11T14:15:39.295983Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Forward request Private::PingTask
2025-11-11T14:15:39.296383Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065, Request CP::PingTask with size: 122 bytes
2025-11-11T14:15:39.296455Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2065"
query_id {
  value: "ptqudslmrtndheehsf29"
}
status: RUNNING
resources {
  rate_limiter: PREPARE
  compilation: PREPARE
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956939
  nanos: 218567000
}
tenant: "/default"
}
2025-11-11T14:15:39.306640Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870559 nanos: 300000000 } } SUCCESS
2025-11-11T14:15:39.306666Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065, Got CP::PingTaskResponse
2025-11-11T14:15:39.306958Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Ping response success: { expired_at { seconds: 1762870559 nanos: 300000000 } }
2025-11-11T14:15:39.306973Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Forward request Private::PingTask
2025-11-11T14:15:39.307404Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065, Request CP::PingTask with size: 191 bytes
2025-11-11T14:15:39.307486Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2065"
query_id {
  value: "ptqudslmrtndheehsf29"
}
status: RUNNING
resources {
  rate_limiter: READY
  compilation: PREPARE
  rate_limiter_path: "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956939
  nanos: 218567000
}
tenant: "/default"
}
2025-11-11T14:15:39.319375Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870559 nanos: 313000000 } } SUCCESS
2025-11-11T14:15:39.319413Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065, Got CP::PingTaskResponse
2025-11-11T14:15:39.319695Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Ping response success: { expired_at { seconds: 1762870559 nanos: 313000000 } }
2025-11-11T14:15:39.319708Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Forward request Private::PingTask
2025-11-11T14:15:39.321033Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065, Request CP::PingTask with size: 113 bytes
2025-11-11T14:15:39.321114Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2065"
query_id {
  value: "ptqudslmrtndheehsf29"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956939
  nanos: 218567000
}
tenant: "/default"
}
2025-11-11T14:15:39.386521Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870559 nanos: 354000000 } } SUCCESS
2025-11-11T14:15:39.386551Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065, Got CP::PingTaskResponse
2025-11-11T14:15:39.386812Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Ping response success: { expired_at { seconds: 1762870559 nanos: 354000000 } }
2025-11-11T14:15:39.386823Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Forward request Private::PingTask
2025-11-11T14:15:39.387237Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065, Request CP::PingTask with size: 583 bytes
2025-11-11T14:15:39.387344Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2065"
query_id {
  value: "ptqudslmrtndheehsf29"
}
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
      }
      message: "mismatched input \'blablabla\' expecting {\';\', \'(\', \'$\', ALTER, ANALYZE, BACKUP, BATCH, COMMIT, CREATE, DECLARE, DEFINE, DELETE, DISCARD, DO, DROP, EVALUATE, EXPLAIN, EXPORT, FOR, FROM, GRANT, IF, IMPORT, INSERT, PARALLEL, PRAGMA, PROCESS, REDUCE, REPLACE, RESTORE, REVOKE, ROLLBACK, SELECT, SHOW, UPDATE, UPSERT, USE, VALUES}"
      end_position {
        row: 1
      }
      severity: 1
    }
  }
}
status_code: ABORTED
resources {
  rate_limiter: READY
  compilation: PREPARE
  rate_limiter_path: "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956939
  nanos: 218567000
}
tenant: "/default"
}
2025-11-11T14:15:39.392120Z :YQ_CONTROL_PLANE_STORAGE DEBUG: task_ping.cpp:427: PingTaskRequest (resign):  FAILURE ABORTED 0 2025-11-11T14:15:38.345943Z 0.000000s
2025-11-11T14:15:39.474771Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870539 nanos: 392000000 } } SUCCESS
2025-11-11T14:15:39.474799Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065, Got CP::PingTaskResponse
2025-11-11T14:15:39.475042Z :FQ_PINGER ERROR: pinger.cpp:365: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Ping response error: Query ownership time is over: expired_at=2025-11-11T14:15:39.392000Z < now=2025-11-11T14:15:39.474758Z. Retried 0 times during 0.088029s
2025-11-11T14:15:39.475060Z :FQ_PINGER DEBUG: pinger.cpp:379: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Query finished
2025-11-11T14:15:39.475063Z :FQ_PINGER TRACE: pinger.cpp:187: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2065 Stop Pinger
2025-11-11T14:15:39.514427Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:39.514469Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471313034425980:2290]
2025-11-11T14:15:39.514482Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:39.514496Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:39.514521Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471313034425981:2291]
2025-11-11T14:15:39.514537Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:39.514549Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:39.514559Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471313034425982:2292]
2025-11-11T14:15:39.514586Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrtndheehsf29"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:39.517998Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrtndheehsf29" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870536 nanos: 980865000 } modified_at { seconds: 1762870538 nanos: 345833000 } revision: 2 } started_at { seconds: 1762870539 nanos: 225000000 } execute_mode: RUN status: FAILING last_job_query_revision: 2 last_job_id: "ptjudslmrsdok0ef1207-ptqudslmrtndheehsf29" started_by: "root@builtin" submitted_at { seconds: 1762870538 nanos: 345833000 } } content { type: ANALYTICS name: "q" acl { visibility: PRIVATE } text: "blablabla" } issue { message: "Query failed with code ABORTED at 2025-11-11T14:15:39.392091Z" severity: 1 issues { message: "Failed to parse query" severity: 1 issues { message: "Parse Sql" severity: 1 issues { position { row: 1 } message: "mismatched input \'blablabla\' expecting {\';\', \'(\', \'$\', ALTER, ANALYZE, BACKUP, BATCH, COMMIT, CREATE, DECLARE, DEFINE, DELETE, DISCARD, DO, DROP, EVALUATE, EXPLAIN, EXPORT, FOR, FROM, GRANT, IF, IMPORT, INSERT, PARALLEL, PRAGMA, PROCESS, REDUCE, REPLACE, RESTORE, REVOKE, ROLLBACK, SELECT, SHOW, UPDATE, UPSERT, USE, VALUES}" end_position { row: 1 } severity: 1 } } } } } } SUCCESS
2025-11-11T14:15:40.020348Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:40.020395Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471317329393282:2295]
2025-11-11T14:15:40.020419Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:40.020453Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:40.020496Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471317329393283:2296]
2025-11-11T14:15:40.020522Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:40.020537Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:40.020570Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471317329393284:2297]
2025-11-11T14:15:40.020626Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrtndheehsf29"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:40.023520Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrtndheehsf29" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870536 nanos: 980865000 } modified_at { seconds: 1762870538 nanos: 345833000 } revision: 2 } started_at { seconds: 1762870539 nanos: 225000000 } execute_mode: RUN status: FAILING last_job_query_revision: 2 last_job_id: "ptjudslmrsdok0ef1207-ptqudslmrtndheehsf29" started_by: "root@builtin" submitted_at { seconds: 1762870538 nanos: 345833000 } } content { type: ANALYTICS name: "q" acl { visibility: PRIVATE } text: "blablabla" } issue { message: "Query failed with code ABORTED at 2025-11-11T14:15:39.392091Z" severity: 1 issues { message: "Failed to parse query" severity: 1 issues { message: "Parse Sql" severity: 1 issues { position { row: 1 } message: "mismatched input \'blablabla\' expecting {\';\', \'(\', \'$\', ALTER, ANALYZE, BACKUP, BATCH, COMMIT, CREATE, DECLARE, DEFINE, DELETE, DISCARD, DO, DROP, EVALUATE, EXPLAIN, EXPORT, FOR, FROM, GRANT, IF, IMPORT, INSERT, PARALLEL, PRAGMA, PROCESS, REDUCE, REPLACE, RESTORE, REVOKE, ROLLBACK, SELECT, SHOW, UPDATE, UPSERT, USE, VALUES}" end_position { row: 1 } severity: 1 } } } } } } SUCCESS
2025-11-11T14:15:40.202871Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:617: RowDispatcher: Send ping to [1:7571471300149523897:2111]
2025-11-11T14:15:40.202897Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1161: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-11T14:15:40.202904Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:314: Coordinator: TEvPing received, [1:7571471300149523838:2069]
2025-11-11T14:15:40.202908Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:317: Coordinator: Send TEvPong to [1:7571471300149523838:2069]
2025-11-11T14:15:40.202918Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:623: RowDispatcher: NActors::TEvents::TEvPong
2025-11-11T14:15:40.203910Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-11-11T14:15:40.203921Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2067, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:40.203943Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-11-11T14:15:40.203948Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 0
2025-11-11T14:15:40.204403Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2067, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:15:40.204464Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2067"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:15:40.207277Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:456: Task (Query): ptqudslmrtndheehsf29 Lease TIMEOUT, RetryCounterUpdatedAt 2025-11-11T14:15:38.345943Z LastSeenAt: 2025-11-11T14:15:39.392186Z
2025-11-11T14:15:40.207289Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:463: Task (Query): ptqudslmrtndheehsf29 RetryRate: 1.999757814 RetryCounter: 1 At: 2025-11-11T14:15:40.207244Z
2025-11-11T14:15:40.215414Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {tasks { query_id { value: "ptqudslmrtndheehsf29" } job_id { value: "ptjudslmrsdok0ef1207" } generation: 3 dq_graph: "\022\320\002\010\001\022\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\000\032\004\010\240\215\00628\n4\010\001\030\002 \001*\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\0002\024\n\022\t\001\000\000\000\000\000\000\000\021\000\000\000\000\001\000\000\000X\001R\000:s\n*type.googleapis.com/Yql.DqsProto.TTaskMeta\022E\010\001\022A\022(8d73c3b672aec01e659c446142c7a17d47fb7b86\032\023dq_vanilla_job.lite \002H\001RClocal/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiterZ)mock_cloud/my_folder/ptqudslmrtndheehsf29`\200\200\200\200 \312\001\010/default\"\017\037\000\205\002\203\002\034column0/*\007column02qptqudslmrtndheehsf29#ptrudslmrta58061b6np#yandexcloud://my_folder#375f7e2d-78674bb5-bf909c3d-ca55f2062#mock_cloud:\025\n\020AnalyticsHopping\022\0011:\034\n\017_LiteralTimeout\022\t604800000:\032\n\r_TableTimeout\022\t604800000:\037\n\025_AllResultsBytesLimit\022\006100000:\032\n\022_RowsLimitPerWrite\022\0041000:\027\n\022EnableComputeActor\022\0011:\016\n\014WorkerFilter:\031\n\020ComputeActorType\022\005async:\031\n\016WatermarksMode\022\007disable:\037\n\027WatermarksGranularityMs\022\0041000:$\n\034WatermarksLateArrivalDelayMs\022\0045000:\027\n\022EnableChannelStats\022\0011:\020\n\013ExportStats\022\0011be\010\001\022a\037\000\005\205\006\213\000\205\000\204\205\002\203\002\034column0\030Inputs(Parameters\034Program\013\213\000)\251\000?\002\014Arg\000\004)\211\002?\010\206?\006 Iterator\000\006\002?\024\005?\006\003?\004\250\001\001\001\002\001/" text: "blablabla" 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: "q" deadline { seconds: 1762956940 nanos: 210105000 } disposition { } result_limit: 20971520 execution_limit { seconds: 86400 } request_started_at { seconds: 1762870539 nanos: 225000000 } restart_count: 1 resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter" } compute_connection { } result_ttl { seconds: 86400 } request_submitted_at { seconds: 1762870538 nanos: 345833000 } } } SUCCESS
2025-11-11T14:15:40.215458Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2067, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:15:40.215770Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:40.215790Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 1
2025-11-11T14:15:40.215802Z :FQ_PENDING_FETCHER DEBUG: pending_fetcher.cpp:361: NewTask: Scope: yandexcloud://my_folder Id: ptqudslmrtndheehsf29 UserId: root@builtin AuthToken: **** (B6C6F477)
2025-11-11T14:15:40.215918Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:375: QueryId: ptqudslmrtndheehsf29 Start run actor. Compute state: FAILING
2025-11-11T14:15:40.215925Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:469: QueryId: ptqudslmrtndheehsf29 FillConnections
2025-11-11T14:15:40.215937Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2068, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:40.215941Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:2333: QueryId: ptqudslmrtndheehsf29 Run actors params: { QueryId: ptqudslmrtndheehsf29 CloudId: mock_cloud UserId: root@builtin Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2067 PreviousQueryRevision: 3 Connections: 0 Bindings: 0 AccountIdSignatures: 0 QueryType: ANALYTICS ExecuteMode: RUN ResultId: ptrudslmrqkmf2fqiudl StateLoadMode: EMPTY StreamingDisposition: {  } Status: FAILING DqGraphs: 1 DqGraphIndex: 0 Resource.TopicConsumers: 0 }
2025-11-11T14:15:40.215952Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1827: QueryId: ptqudslmrtndheehsf29 Is about to finish query with status FAILED
2025-11-11T14:15:40.215962Z :FQ_PINGER TRACE: pinger.cpp:171: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2067 Start Pinger
2025-11-11T14:15:40.215962Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1508: QueryId: ptqudslmrtndheehsf29 Start rate limiter resource deleter
2025-11-11T14:15:40.216320Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2068, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:15:40.216356Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2068"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:15:40.216415Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:175: PrivateDeleteRateLimiterResource - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2067, Request CP::DeleteRateLimiterResource with size: 97 bytes
2025-11-11T14:15:40.216462Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: DeleteRateLimiterResourceRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2067"
query_id {
  value: "ptqudslmrtndheehsf29"
}
scope: "yandexcloud://my_folder"
tenant: "/default"
} 
2025-11-11T14:15:40.218700Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-11-11T14:15:40.218730Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2068, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:15:40.218824Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: DeleteRateLimiterResourceRequest. Got response from database: SUCCESS
2025-11-11T14:15:40.218898Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run delete rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29" actor
2025-11-11T14:15:40.218904Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call delete rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29"
2025-11-11T14:15:40.218963Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:40.218971Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-11-11T14:15:40.220552Z :YQ_RATE_LIMITER DEBUG: schema.cpp:179: Successfully deleted rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29"
2025-11-11T14:15:40.220563Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for delete rate limiter resource "mock_cloud/my_folder/ptqudslmrtndheehsf29": 
2025-11-11T14:15:40.220590Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:219: Got delete response from rate limiter service
2025-11-11T14:15:40.220611Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:199: PrivateDeleteRateLimiterResource - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2067, Got CP::DeleteRateLimiterResourceResponse
2025-11-11T14:15:40.220907Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1499: QueryId: ptqudslmrtndheehsf29 Rate limiter resource deletion finished. Success: 1. Issues: 
2025-11-11T14:15:40.220918Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1919: QueryId: ptqudslmrtndheehsf29 SendPingAndPassAway, FinalQueryStatus FAILED
2025-11-11T14:15:40.220931Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:536: QueryId: ptqudslmrtndheehsf29 PassAway
2025-11-11T14:15:40.220979Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2067 Forward ping request: { result_id { } status: FAILED resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter" } finished_at { seconds: 1762870540 nanos: 215000000 } }
2025-11-11T14:15:40.220989Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2067 Forward request Private::PingTask
2025-11-11T14:15:40.221373Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2067, Request CP::PingTask with size: 207 bytes
2025-11-11T14:15:40.221470Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "375f7e2d-78674bb5-bf909c3d-ca55f2067"
query_id {
  value: "ptqudslmrtndheehsf29"
}
result_id {
}
status: FAILED
resources {
  rate_limiter: READY
  compilation: PREPARE
  rate_limiter_path: "local/RateLimiter_c68853c5-29df-4a95-a52e-3dbc313cd4e2/rate_limiter"
}
scope: "yandexcloud://my_folder"
finished_at {
  seconds: 1762870540
  nanos: 215000000
}
deadline {
  seconds: 1762956940
  nanos: 210105000
}
tenant: "/default"
}
2025-11-11T14:15:40.226387Z :YQ_CONTROL_PLANE_STORAGE NOTICE: task_ping.cpp:224: Query ptqudslmrtndheehsf29 is NOT billable, status: FAILED, statusCode: ABORTED
2025-11-11T14:15:40.295222Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {} SUCCESS
2025-11-11T14:15:40.295296Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2067, Got CP::PingTaskResponse
2025-11-11T14:15:40.295607Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2067 Ping response success: {  }
2025-11-11T14:15:40.295619Z :FQ_PINGER DEBUG: pinger.cpp:379: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2067 Query finished
2025-11-11T14:15:40.295623Z :FQ_PINGER TRACE: pinger.cpp:187: QueryId: ptqudslmrtndheehsf29, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2067 Stop Pinger
2025-11-11T14:15:40.525894Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:40.525951Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471317329393306:2318]
2025-11-11T14:15:40.525986Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:40.526020Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:40.526082Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471317329393307:2319]
2025-11-11T14:15:40.526132Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:40.526168Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:40.526194Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471317329393308:2320]
2025-11-11T14:15:40.526238Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrtndheehsf29"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:40.529483Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrtndheehsf29" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870536 nanos: 980865000 } modified_at { seconds: 1762870538 nanos: 345833000 } revision: 2 } started_at { seconds: 1762870539 nanos: 225000000 } finished_at { seconds: 1762870540 nanos: 215000000 } execute_mode: RUN status: FAILED last_job_query_revision: 2 last_job_id: "ptjudslmrsdok0ef1207-ptqudslmrtndheehsf29" started_by: "root@builtin" submitted_at { seconds: 1762870538 nanos: 345833000 } } content { type: ANALYTICS name: "q" acl { visibility: PRIVATE } text: "blablabla" } issue { message: "Query failed with code ABORTED at 2025-11-11T14:15:39.392091Z" severity: 1 issues { message: "Failed to parse query" severity: 1 issues { message: "Parse Sql" severity: 1 issues { position { row: 1 } message: "mismatched input \'blablabla\' expecting {\';\', \'(\', \'$\', ALTER, ANALYZE, BACKUP, BATCH, COMMIT, CREATE, DECLARE, DEFINE, DELETE, DISCARD, DO, DROP, EVALUATE, EXPLAIN, EXPORT, FOR, FROM, GRANT, IF, IMPORT, INSERT, PARALLEL, PRAGMA, PROCESS, REDUCE, REPLACE, RESTORE, REVOKE, ROLLBACK, SELECT, SHOW, UPDATE, UPSERT, USE, VALUES}" end_position { row: 1 } severity: 1 } } } } } } SUCCESS
2025-11-11T14:15:40.531461Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:40.531501Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471317329393312:2323]
2025-11-11T14:15:40.531532Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:40.531550Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:40.531582Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471317329393313:2324]
2025-11-11T14:15:40.531610Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:40.531634Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrtndheehsf29"
2025-11-11T14:15:40.531671Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471317329393314:2325]
2025-11-11T14:15:40.531725Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrtndheehsf29"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:40.534500Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrtndheehsf29" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870536 nanos: 980865000 } modified_at { seconds: 1762870538 nanos: 345833000 } revision: 2 } started_at { seconds: 1762870539 nanos: 225000000 } finished_at { seconds: 1762870540 nanos: 215000000 } execute_mode: RUN status: FAILED last_job_query_revision: 2 last_job_id: "ptjudslmrsdok0ef1207-ptqudslmrtndheehsf29" started_by: "root@builtin" submitted_at { seconds: 1762870538 nanos: 345833000 } } content { type: ANALYTICS name: "q" acl { visibility: PRIVATE } text: "blablabla" } issue { message: "Query failed with code ABORTED at 2025-11-11T14:15:39.392091Z" severity: 1 issues { message: "Failed to parse query" severity: 1 issues { message: "Parse Sql" severity: 1 issues { position { row: 1 } message: "mismatched input \'blablabla\' expecting {\';\', \'(\', \'$\', ALTER, ANALYZE, BACKUP, BATCH, COMMIT, CREATE, DECLARE, DEFINE, DELETE, DISCARD, DO, DROP, EVALUATE, EXPLAIN, EXPORT, FOR, FROM, GRANT, IF, IMPORT, INSERT, PARALLEL, PRAGMA, PROCESS, REDUCE, REPLACE, RESTORE, REVOKE, ROLLBACK, SELECT, SHOW, UPDATE, UPSERT, USE, VALUES}" end_position { row: 1 } severity: 1 } } } } } } SUCCESS
2025-11-11T14:15:41.202328Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-11-11T14:15:41.204351Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-11-11T14:15:41.204372Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-11-11T14:15:41.204376Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 0
2025-11-11T14:15:41.204381Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f2069, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:41.207339Z :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:25108: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-vb3yoermsa.auto.internal:25108
2025-11-11T14:15:41.207349Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:41.207364Z :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:25108: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-vb3yoermsa.auto.internal:25108
2025-11-11T14:15:42.203806Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:617: RowDispatcher: Send ping to [1:7571471300149523897:2111]
2025-11-11T14:15:42.203835Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1161: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-11T14:15:42.203849Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:314: Coordinator: TEvPing received, [1:7571471300149523838:2069]
2025-11-11T14:15:42.203854Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:317: Coordinator: Send TEvPong to [1:7571471300149523838:2069]
2025-11-11T14:15:42.203872Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:623: RowDispatcher: NActors::TEvents::TEvPong
2025-11-11T14:15:42.204804Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-11-11T14:15:42.204812Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f20610, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:42.204823Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-11-11T14:15:42.204830Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 0
2025-11-11T14:15:42.209685Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:42.209706Z :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:25108: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-vb3yoermsa.auto.internal:25108
2025-11-11T14:15:42.254142Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-11-11T14:15:43.205434Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-11-11T14:15:43.205453Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f20611, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:43.205456Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-11-11T14:15:43.205462Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 0
2025-11-11T14:15:43.213485Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:43.213503Z :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:25108: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-vb3yoermsa.auto.internal:25108
2025-11-11T14:15:44.204674Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:617: RowDispatcher: Send ping to [1:7571471300149523897:2111]
2025-11-11T14:15:44.204693Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1161: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-11T14:15:44.204712Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:314: Coordinator: TEvPing received, [1:7571471300149523838:2069]
2025-11-11T14:15:44.204717Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:317: Coordinator: Send TEvPong to [1:7571471300149523838:2069]
2025-11-11T14:15:44.204733Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:623: RowDispatcher: NActors::TEvents::TEvPong
2025-11-11T14:15:44.205710Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-11-11T14:15:44.205721Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 375f7e2d-78674bb5-bf909c3d-ca55f20612, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:44.205725Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-11-11T14:15:44.205730Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 0
2025-11-11T14:15:44.210642Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:44.210662Z :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:25108: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-vb3yoermsa.auto.internal:25108
