2025-12-12T12:26:50.911870Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:544: RowDispatcher: Successfully bootstrapped row dispatcher, id [1:7582946911894768519:2069], tenant /default
2025-12-12T12:26:50.911896Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [1:7582946911894768519:2069]
2025-12-12T12:26:50.911898Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:329: Coordinator: Add new row dispatcher to map (state 1)
2025-12-12T12:26:50.912138Z :GRPC_SERVER NOTICE: grpc_request_proxy_simple.cpp:161: Grpc simple request proxy started, nodeid# 1
2025-12-12T12:26:50.912177Z :GRPC_SERVER NOTICE: grpc_request_proxy_simple.cpp:161: Grpc simple request proxy started, nodeid# 1
2025-12-12T12:26:50.912379Z :FQ_CONTROL_PLANE_CONFIG DEBUG: control_plane_config.cpp:58: STARTING: [1:7582946911894768513:2063]
2025-12-12T12:26:50.912697Z :YQL_NODES_MANAGER INFO: nodes_manager.cpp:88: Bootstrap, InstanceId: cd1ef00f-46633fc8-ba674b4-747e39e0
2025-12-12T12:26:50.912699Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:310: TNodesManagerActor::ResolveSelfAddress
2025-12-12T12:26:50.912708Z :YQ_TEST_CONNECTION DEBUG: test_connection.cpp:142: Starting yandex query test connection. Actor id: [1:7582946911894768524:2074]
2025-12-12T12:26:50.912736Z :FQ_LOG_UPDATER DEBUG: log.cpp:93: Updated YQL logs priority: 8
2025-12-12T12:26:50.912741Z :FQ_LOG_UPDATER CRIT: log.cpp:55: Failed to deliver subscription request to config dispatcher.
2025-12-12T12:26:50.912887Z :FQ_QUOTA_SERVICE INFO: quota_manager.cpp:196: STARTED
2025-12-12T12:26:50.912892Z :YQ_CONTROL_PLANE_STORAGE INFO: ydb_control_plane_storage.cpp:50: Starting ydb control plane storage service. Actor id: [1:7582946911894768512:2062]
2025-12-12T12:26:50.913100Z :YQ_CONTROL_PLANE_PROXY DEBUG: control_plane_proxy.cpp:525: Starting yandex query control plane proxy. Actor id: [1:7582946911894768514:2064]
2025-12-12T12:26:50.913181Z :YQ_RATE_LIMITER INFO: quoter_service.cpp:124: Bootstraping with config: { Enabled: true ControlPlaneEnabled: true DataPlaneEnabled: true Database { Endpoint: "localhost:20104" Database: "local" TablePrefix: "RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471" } Limiters { CoordinationNodePath: "rate_limiter" } }
2025-12-12T12:26:50.913380Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/bindings" actor
2025-12-12T12:26:50.913405Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:293: Coordinator: Successfully bootstrapped coordinator, id [1:7582946911894768535:2081], NodesManagerId [0:4705493345362661702:78], rebalancing timeout 5.000000s
2025-12-12T12:26:50.913414Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/idempotency_keys" actor
2025-12-12T12:26:50.913424Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:232: TLeaderElection [1:7582946911894768536:2082] Successfully bootstrapped, local coordinator id [1:7582946911894768535:2081], tenant id default, local mode 0, coordination node path local/default, endpoint localhost:20104
2025-12-12T12:26:50.913424Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/result_sets" actor
2025-12-12T12:26:50.913431Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/jobs" actor
2025-12-12T12:26:50.913474Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f1, Host: ghrun-fhkyrtz6p4, Tenant: /default
2025-12-12T12:26:50.913483Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/mappings" actor
2025-12-12T12:26:50.913492Z :FQ_QUOTA_PROXY INFO: quota_proxy.cpp:90: STARTED
2025-12-12T12:26:50.913495Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create coordination node "local/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter" actor
2025-12-12T12:26:50.913497Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create coordination node "local/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter"
2025-12-12T12:26:50.913499Z :YQ_RATE_LIMITER DEBUG: schema.cpp:411: Call create coordination node "local/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter"
2025-12-12T12:26:50.913524Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create directory "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471" actor
2025-12-12T12:26:50.913525Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create directory "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471"
2025-12-12T12:26:50.913527Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:383: Call create directory "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471"
2025-12-12T12:26:50.913543Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/queries" actor
2025-12-12T12:26:50.913551Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/pending_small" actor
2025-12-12T12:26:50.913558Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:214: Bootstrap
2025-12-12T12:26:50.913559Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:217: Create sdk ydb connection
2025-12-12T12:26:50.913746Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:239: Successfully bootstrapped TStorageProxy [1:7582946911894768518:2068] with connection to localhost:20104:local
2025-12-12T12:26:50.913753Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/connections" actor
2025-12-12T12:26:50.913780Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:637: RowDispatcher: TEvCoordinatorChangesSubscribe from [1:7582946911894768535:2081]
2025-12-12T12:26:50.913785Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/nodes" actor
2025-12-12T12:26:50.913911Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/quotas" actor
2025-12-12T12:26:50.913930Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/tenants" actor
2025-12-12T12:26:50.913941Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-12-12T12:26:50.914143Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/tenant_acks" actor
2025-12-12T12:26:50.914171Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/compute_databases" actor
2025-12-12T12:26:50.919558Z :MEMORY_PROFILER NOTICE: monitor.cpp:332: Bootstrapped
2025-12-12T12:26:50.920109Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:71: Run create coordination node "local/default" actor
2025-12-12T12:26:50.920119Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:113: Call create coordination node "local/default"
2025-12-12T12:26:50.920122Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:411: Call create coordination node "local/default"
2025-12-12T12:26:50.930324Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-12T12:26:50.930341Z :FQ_PENDING_FETCHER ERROR: pending_fetcher.cpp:259: Error with GetTask: <main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv6:%5B::1%5D:25467: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint localhost:25467
2025-12-12T12:26:50.930391Z :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: ipv6:%5B::1%5D:25467: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint localhost:25467
2025-12-12T12:26:50.943204Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/quotas". Create session OK
2025-12-12T12:26:50.943211Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/quotas"
2025-12-12T12:26:50.943213Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/quotas"
2025-12-12T12:26:50.943226Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/mappings". Create session OK
2025-12-12T12:26:50.943231Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/mappings"
2025-12-12T12:26:50.943243Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/mappings"
2025-12-12T12:26:50.943386Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/queries". Create session OK
2025-12-12T12:26:50.943389Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/queries"
2025-12-12T12:26:50.943390Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/queries"
2025-12-12T12:26:50.943403Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/compute_databases". Create session OK
2025-12-12T12:26:50.943405Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/compute_databases"
2025-12-12T12:26:50.943407Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/compute_databases"
2025-12-12T12:26:50.943424Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/connections". Create session OK
2025-12-12T12:26:50.943428Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/connections"
2025-12-12T12:26:50.943431Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/connections"
2025-12-12T12:26:50.943482Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/tenant_acks". Create session OK
2025-12-12T12:26:50.943484Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/tenant_acks"
2025-12-12T12:26:50.943486Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/tenant_acks"
2025-12-12T12:26:50.949808Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:155: Successfully created coordination node "local/default"
2025-12-12T12:26:50.949820Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:122: Reply for create coordination node "local/default": { <main>: Error: Check failed: path: '/local/default', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 5], type: EPathTypeKesus, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_kesus.cpp:339 }
2025-12-12T12:26:50.949836Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:345: TLeaderElection [1:7582946911894768536:2082] Coordination node successfully created
2025-12-12T12:26:50.949839Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:323: TLeaderElection [1:7582946911894768536:2082] Start session
2025-12-12T12:26:50.951073Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/tenants". Create session OK
2025-12-12T12:26:50.951080Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/tenants"
2025-12-12T12:26:50.951082Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/tenants"
2025-12-12T12:26:50.951205Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/jobs". Create session OK
2025-12-12T12:26:50.951211Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/jobs"
2025-12-12T12:26:50.951214Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/jobs"
2025-12-12T12:26:50.951299Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/pending_small". Create session OK
2025-12-12T12:26:50.951302Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/pending_small"
2025-12-12T12:26:50.951305Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/pending_small"
2025-12-12T12:26:50.951386Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/result_sets". Create session OK
2025-12-12T12:26:50.951388Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/result_sets"
2025-12-12T12:26:50.951390Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/result_sets"
2025-12-12T12:26:50.951445Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/idempotency_keys". Create session OK
2025-12-12T12:26:50.951447Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/idempotency_keys"
2025-12-12T12:26:50.951447Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/idempotency_keys"
2025-12-12T12:26:50.951458Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/bindings". Create session OK
2025-12-12T12:26:50.951460Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/bindings"
2025-12-12T12:26:50.951462Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/bindings"
2025-12-12T12:26:50.951492Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/nodes". Create session OK
2025-12-12T12:26:50.951494Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/nodes"
2025-12-12T12:26:50.951494Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/nodes"
2025-12-12T12:26:50.951548Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created directory "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471"
2025-12-12T12:26:50.951551Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/mappings"
2025-12-12T12:26:50.951556Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create directory "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471": { <main>: Error: Check failed: path: '/local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 19], type: EPathTypeDir, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_mkdir.cpp:155 }
2025-12-12T12:26:50.951562Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/mappings": { <main>: Error: Check failed: path: '/local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/mappings', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 21], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504 }
2025-12-12T12:26:50.963683Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/tenants"
2025-12-12T12:26:50.963702Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/tenants": { <main>: Error: Check failed: path: '/local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/tenants', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 20], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504 }
2025-12-12T12:26:50.966843Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:359: TLeaderElection [1:7582946911894768536:2082] Session successfully created
2025-12-12T12:26:50.976723Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:372: TLeaderElection [1:7582946911894768536:2082] Semaphore successfully created
2025-12-12T12:26:50.976737Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:304: TLeaderElection [1:7582946911894768536:2082] Try to acquire semaphore
2025-12-12T12:26:50.976806Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:420: TLeaderElection [1:7582946911894768536:2082] Describe semaphore
2025-12-12T12:26:50.990926Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:386: TLeaderElection [1:7582946911894768536:2082] Semaphore successfully acquired
2025-12-12T12:26:50.990950Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:469: TLeaderElection [1:7582946911894768536:2082] Semaphore successfully described: coordinator id [1:7582946911894768535:2081] generation 2
2025-12-12T12:26:50.990954Z :FQ_ROW_DISPATCHER INFO: leader_election.cpp:471: TLeaderElection [1:7582946911894768536:2082] Send TEvCoordinatorChanged to [1:7582946911894768519:2069], new coordinator id [1:7582946911894768535:2081], previous coordinator id [0:0:0]
2025-12-12T12:26:50.990972Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:569: RowDispatcher: Coordinator changed, old leader (empty maybe), new [1:7582946911894768535:2081] generation 2
2025-12-12T12:26:50.990988Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:356: Coordinator: TEvPing received, [1:7582946911894768519:2069]
2025-12-12T12:26:50.990992Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [1:7582946911894768519:2069]
2025-12-12T12:26:50.990994Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:359: Coordinator: Send TEvPong to [1:7582946911894768519:2069]
2025-12-12T12:26:50.991018Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:440: Coordinator: New leader [1:7582946911894768535:2081], SelfId [1:7582946911894768535:2081]
2025-12-12T12:26:50.991021Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-12T12:26:50.998800Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created coordination node "local/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter"
2025-12-12T12:26:50.998817Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create coordination node "local/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter": 
2025-12-12T12:26:51.001245Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/queries"
2025-12-12T12:26:51.001266Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/queries": 
2025-12-12T12:26:51.001671Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/compute_databases"
2025-12-12T12:26:51.001678Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/compute_databases": 
2025-12-12T12:26:51.004855Z :FQ_CONTROL_PLANE_CONFIG DEBUG: control_plane_config.cpp:190: LOADED TenantInfo: State CHANGED at 2025-12-12T12:26:50.070439Z
2025-12-12T12:26:51.010178Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/result_sets"
2025-12-12T12:26:51.010192Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/result_sets": 
2025-12-12T12:26:51.010434Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/pending_small"
2025-12-12T12:26:51.010443Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/pending_small": 
2025-12-12T12:26:51.010563Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/tenant_acks"
2025-12-12T12:26:51.010565Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/tenant_acks": 
2025-12-12T12:26:51.010645Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/bindings"
2025-12-12T12:26:51.010647Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/bindings": 
2025-12-12T12:26:51.010736Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/jobs"
2025-12-12T12:26:51.010738Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/jobs": 
2025-12-12T12:26:51.012197Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/idempotency_keys"
2025-12-12T12:26:51.012202Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/idempotency_keys": 
2025-12-12T12:26:51.012408Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/nodes"
2025-12-12T12:26:51.012424Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/nodes": 
2025-12-12T12:26:51.012510Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/quotas"
2025-12-12T12:26:51.012519Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/quotas": 
2025-12-12T12:26:51.012609Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/connections"
2025-12-12T12:26:51.012617Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_9865b209-1f3d-429e-89d8-16533d8bf471/connections": 
2025-12-12T12:26:51.910369Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f2, Host: ghrun-fhkyrtz6p4, Tenant: /default
2025-12-12T12:26:51.947718Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f2, Host: ghrun-fhkyrtz6p4, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-12-12T12:26:51.948522Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f2"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:26:52.008999Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:26:52.009042Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f2, Host: ghrun-fhkyrtz6p4, Tenant: /default, Got CP::GetTask Response
2025-12-12T12:26:52.009600Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-12T12:26:52.009612Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-12T12:26:52.913601Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7582946911894768535:2081]
2025-12-12T12:26:52.913616Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-12T12:26:52.913652Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f3, Host: ghrun-fhkyrtz6p4, Tenant: /default
2025-12-12T12:26:52.913671Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:356: Coordinator: TEvPing received, [1:7582946911894768519:2069]
2025-12-12T12:26:52.913675Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [1:7582946911894768519:2069]
2025-12-12T12:26:52.913679Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:359: Coordinator: Send TEvPong to [1:7582946911894768519:2069]
2025-12-12T12:26:52.913915Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-12T12:26:52.915216Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f3, Host: ghrun-fhkyrtz6p4, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-12-12T12:26:52.915277Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f3"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:26:52.923819Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:26:52.923893Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f3, Host: ghrun-fhkyrtz6p4, Tenant: /default, Got CP::GetTask Response
2025-12-12T12:26:52.924438Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-12T12:26:52.924448Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-12T12:26:53.303262Z :TICKET_PARSER DEBUG: ticket_parser_impl.h:1875: Ticket **** (B6C6F477) (ipv6:[::1]:53876) has now valid token of root@builtin
2025-12-12T12:26:53.303419Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:648: CreateQueryRequest: content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "0a4d9114-55f9-4443-8853-8f723326f974"
2025-12-12T12:26:53.303463Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582946924779670523:2161]
2025-12-12T12:26:53.303483Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:26:53.303498Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582946924779670524:2162]
2025-12-12T12:26:53.303509Z :FQ_QUOTA_SERVICE DEBUG: quota_manager.cpp:255: cloud.mock_cloud NOT CASHED, Loading ...
2025-12-12T12:26:53.339061Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:441: cloud.mock_cloud {} FROM DB
2025-12-12T12:26:53.339109Z :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-12-12T12:26:53.339115Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:53.339129Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:26:53.339134Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:53.339170Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:26:53.404928Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:26:53.408885Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:26:53.408916Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=0/100 REFRESHED
2025-12-12T12:26:53.408952Z :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-12-12T12:26:53.408964Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:26:53.409033Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:648: CreateQueryRequest: content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "0a4d9114-55f9-4443-8853-8f723326f974"
2025-12-12T12:26:53.409112Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582946924779670530:2168]
2025-12-12T12:26:53.409141Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:26:53.409164Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:648: CreateQueryRequest: content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "0a4d9114-55f9-4443-8853-8f723326f974"
2025-12-12T12:26:53.409189Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:435: Create database bootstrap. CloudId: mock_cloud Scope: yandexcloud://my_folder Actor id: [1:7582946924779670531:2169]
2025-12-12T12:26:53.409217Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:648: CreateQueryRequest: content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "0a4d9114-55f9-4443-8853-8f723326f974"
2025-12-12T12:26:53.409233Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582946924779670532:2170]
2025-12-12T12:26:53.409251Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:248: Create rate limiter resource for cloud with limit 100000ms
2025-12-12T12:26:53.409279Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create rate limiter resource "mock_cloud" actor
2025-12-12T12:26:53.409284Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud"
2025-12-12T12:26:53.416808Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created rate limiter resource "mock_cloud"
2025-12-12T12:26:53.416822Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create rate limiter resource "mock_cloud": 
2025-12-12T12:26:53.416869Z :YQ_CONTROL_PLANE_PROXY DEBUG: request_actor.h:272: Create response from rate limiter service. Success: 1
2025-12-12T12:26:53.416982Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:226: CreateQueryRequest: {content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "0a4d9114-55f9-4443-8853-8f723326f974"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:26:53.417226Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:26:53.417240Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:26:53.626288Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: CreateQueryRequest - CreateQueryResult: {query_id: "ptqudq7ufppheikkkd58" } SUCCESS
2025-12-12T12:26:53.632427Z :TICKET_PARSER DEBUG: ticket_parser_impl.h:1875: Ticket **** (B6C6F477) (ipv6:[::1]:53876) has now valid token of root@builtin
2025-12-12T12:26:53.632505Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:53.632533Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582946924779670537:2174]
2025-12-12T12:26:53.632547Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:26:53.632559Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582946924779670538:2175]
2025-12-12T12:26:53.632573Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:53.632580Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:26:53.632584Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:53.632644Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:26:53.642110Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:26:53.663468Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:26:53.663512Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=1/100 REFRESHED
2025-12-12T12:26:53.663536Z :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=1/100} SEND QUOTAS
2025-12-12T12:26:53.663549Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:26:53.663581Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:53.663655Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582946924779670543:2180]
2025-12-12T12:26:53.663680Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:26:53.663696Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:53.663713Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582946924779670544:2181]
2025-12-12T12:26:53.663757Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudq7ufppheikkkd58"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:26:53.675463Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:26:53.675584Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=1/100 NOTIFY CHANGE
2025-12-12T12:26:53.724083Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudq7ufppheikkkd58" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1765542413 nanos: 416891000 } modified_at { seconds: 1765542413 nanos: 416891000 } revision: 1 } execute_mode: RUN status: STARTING last_job_query_revision: 1 last_job_id: "ptjudq7ufpphdsf7akqv-ptqudq7ufppheikkkd58" started_by: "root@builtin" submitted_at { seconds: 1765542413 nanos: 416891000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "SELECT 42;" syntax: YQL_V1 } } } SUCCESS
2025-12-12T12:26:53.914714Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Host: ghrun-fhkyrtz6p4, Tenant: /default
2025-12-12T12:26:53.915451Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Host: ghrun-fhkyrtz6p4, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-12-12T12:26:53.915518Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f4"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:26:53.924090Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:463: Task (Query): ptqudq7ufppheikkkd58 RetryRate: 0 RetryCounter: 0 At: 2025-12-12T12:26:53.502672Z
2025-12-12T12:26:53.935637Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-12-12T12:26:54.060799Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {tasks { query_id { value: "ptqudq7ufppheikkkd58" } job_id { value: "ptjudq7ufpphdsf7akqv" } generation: 1 streaming: true text: "SELECT 42;" user_token: "root@builtin" user_id: "root@builtin" query_type: STREAMING 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: 1765628813 nanos: 995159000 } disposition { fresh { } } result_limit: 20971520 execution_limit { } request_started_at { } resources { } query_syntax: YQL_V1 compute_connection { } result_ttl { seconds: 86400 } request_submitted_at { seconds: 1765542413 nanos: 416891000 } } } SUCCESS
2025-12-12T12:26:54.060858Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Host: ghrun-fhkyrtz6p4, Tenant: /default, Got CP::GetTask Response
2025-12-12T12:26:54.061222Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-12T12:26:54.061232Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 1
2025-12-12T12:26:54.061246Z :FQ_PENDING_FETCHER DEBUG: pending_fetcher.cpp:361: NewTask: Scope: yandexcloud://my_folder Id: ptqudq7ufppheikkkd58 UserId: root@builtin AuthToken: **** (B6C6F477)
2025-12-12T12:26:54.061379Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:375: QueryId: ptqudq7ufppheikkkd58 Start run actor. Compute state: STARTING
2025-12-12T12:26:54.061382Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:469: QueryId: ptqudq7ufppheikkkd58 FillConnections
2025-12-12T12:26:54.061382Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f5, Host: ghrun-fhkyrtz6p4, Tenant: /default
2025-12-12T12:26:54.061407Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:2333: QueryId: ptqudq7ufppheikkkd58 Run actors params: { QueryId: ptqudq7ufppheikkkd58 CloudId: mock_cloud UserId: root@builtin Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 PreviousQueryRevision: 1 Connections: 0 Bindings: 0 AccountIdSignatures: 0 QueryType: STREAMING ExecuteMode: RUN ResultId: ptrudq7ufp5s91uul840 StateLoadMode: EMPTY StreamingDisposition: { fresh { } } Status: STARTING DqGraphs: 0 DqGraphIndex: 0 Resource.TopicConsumers: 0 }
2025-12-12T12:26:54.061425Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:571: QueryId: ptqudq7ufppheikkkd58 Start rate limiter resource creator
2025-12-12T12:26:54.061441Z :FQ_PINGER TRACE: pinger.cpp:171: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Start Pinger
2025-12-12T12:26:54.061457Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Forward ping request: { started_at { seconds: 1765542414 nanos: 61000000 } }
2025-12-12T12:26:54.061461Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Forward request Private::PingTask
2025-12-12T12:26:54.061478Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Forward ping request: { status: RUNNING resources { rate_limiter: PREPARE compilation: PREPARE } }
2025-12-12T12:26:54.061803Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f5, Host: ghrun-fhkyrtz6p4, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-12-12T12:26:54.061846Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f5"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:26:54.061941Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Request CP::PingTask with size: 128 bytes
2025-12-12T12:26:54.061994Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f4"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
scope: "yandexcloud://my_folder"
started_at {
  seconds: 1765542414
  nanos: 61000000
}
deadline {
  seconds: 1765628813
  nanos: 995159000
}
tenant: "/default"
}
2025-12-12T12:26:54.062069Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:78: PrivateCreateRateLimiterResource - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Request CP::CreateRateLimiterResource with size: 97 bytes
2025-12-12T12:26:54.062110Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: CreateRateLimiterResourceRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f4"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
scope: "yandexcloud://my_folder"
tenant: "/default"
} 
2025-12-12T12:26:54.067247Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:26:54.067322Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f5, Host: ghrun-fhkyrtz6p4, Tenant: /default, Got CP::GetTask Response
2025-12-12T12:26:54.067730Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-12T12:26:54.067734Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-12T12:26:54.105716Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: CreateRateLimiterResourceRequest. Got response from database: SUCCESS
2025-12-12T12:26:54.105829Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58" actor
2025-12-12T12:26:54.105833Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58"
2025-12-12T12:26:54.106903Z :YQ_RATE_LIMITER DEBUG: schema.cpp:261: Trying to recursively create rate limiter resource "mock_cloud/my_folder"
2025-12-12T12:26:54.106913Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder"
2025-12-12T12:26:54.111311Z :YQ_RATE_LIMITER DEBUG: schema.cpp:244: Successfully created rate limiter resource "mock_cloud/my_folder"
2025-12-12T12:26:54.111323Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58"
2025-12-12T12:26:54.115086Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58"
2025-12-12T12:26:54.115099Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58": 
2025-12-12T12:26:54.115136Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:180: Got create response from rate limiter service
2025-12-12T12:26:54.115168Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:102: PrivateCreateRateLimiterResource - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Got CP::CreateRateLimiterResourceResponse
2025-12-12T12:26:54.119272Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1476: QueryId: ptqudq7ufppheikkkd58 Rate limiter resource creation finished. Success: 1
2025-12-12T12:26:54.119293Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1966: QueryId: ptqudq7ufppheikkkd58 Compiling query ...
2025-12-12T12:26:54.119564Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Forward ping request: { status: RUNNING resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter" } }
2025-12-12T12:26:54.198217Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.198 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_facade.cpp:855: Execution of [ParseSql] took 77.7ms
2025-12-12T12:26:54.198651Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.198 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_facade.cpp:898: Execution of [Compile] took 392us
2025-12-12T12:26:54.198776Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.198 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [DQ] yql_dq_provider.cpp:109: OpenSession ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud
2025-12-12T12:26:54.198784Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.198 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [DQ] yql_dq_provider.cpp:112: OpenSession ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud complete in 0
2025-12-12T12:26:54.198863Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.198 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_optimize.cpp:671: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [ExpandApply] took 20us
2025-12-12T12:26:54.198960Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.198 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core eval] yql_eval_expr.cpp:410: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} EvaluateExpression - start
2025-12-12T12:26:54.203209Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.203 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core eval] yql_eval_expr.cpp:1181: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} EvaluateExpression - finish
2025-12-12T12:26:54.203423Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.203 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [PQ] yql_pq_helpers.cpp:100: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Ids to resolve: 0
2025-12-12T12:26:54.203537Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.203 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [RESULT] yql_result_provider.cpp:1418: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} RewriteIO
2025-12-12T12:26:54.204115Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core] type_ann_expr.cpp:159: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Repeated callable stats:
RemovePrefixMembers=1
TypeOf=1
PersistableRepr=1
OrderedSqlProject=1
SqlProjectItem=1
ResWrite!=1

2025-12-12T12:26:54.204131Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 572us
2025-12-12T12:26:54.204190Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 22us
2025-12-12T12:26:54.204198Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 1us
2025-12-12T12:26:54.204244Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_constraint.cpp:3307: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 36us
2025-12-12T12:26:54.204270Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-12-12T12:26:54.204278Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-12-12T12:26:54.204303Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_constraint.cpp:3307: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 17us
2025-12-12T12:26:54.204318Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:638: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [UpdateCompletness] took 7us
2025-12-12T12:26:54.204352Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:651: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [EliminateCommonSubExpressions] took 25us
2025-12-12T12:26:54.204404Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core] yql_out_transformers.cpp:62: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#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-12-12T12:26:54.204564Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core] yql_co_simple1.cpp:6761: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Expand OrderedSqlProject
2025-12-12T12:26:54.204621Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-12-12T12:26:54.204673Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 44us
2025-12-12T12:26:54.204692Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_constraint.cpp:3307: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 12us
2025-12-12T12:26:54.204718Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-12-12T12:26:54.204725Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 1us
2025-12-12T12:26:54.204753Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_constraint.cpp:3307: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 19us
2025-12-12T12:26:54.204766Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:638: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [UpdateCompletness] took 6us
2025-12-12T12:26:54.204795Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:651: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [EliminateCommonSubExpressions] took 22us
2025-12-12T12:26:54.204842Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core] yql_out_transformers.cpp:62: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#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-12-12T12:26:54.204868Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core] yql_opt_utils.cpp:880: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Enumerate struct literal for FlattenMembers
2025-12-12T12:26:54.204914Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-12-12T12:26:54.204948Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 27us
2025-12-12T12:26:54.204965Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_constraint.cpp:3307: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 7us
2025-12-12T12:26:54.204989Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-12-12T12:26:54.204996Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.204 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-12-12T12:26:54.205017Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_constraint.cpp:3307: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 13us
2025-12-12T12:26:54.205030Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:638: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [UpdateCompletness] took 5us
2025-12-12T12:26:54.205052Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:651: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [EliminateCommonSubExpressions] took 16us
2025-12-12T12:26:54.205088Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core] yql_out_transformers.cpp:62: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#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-12-12T12:26:54.205125Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core] yql_co_simple1.cpp:2115: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Fuse OrderedFlatMap over AsList
2025-12-12T12:26:54.205165Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-12-12T12:26:54.205187Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 16us
2025-12-12T12:26:54.205202Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_constraint.cpp:3307: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 7us
2025-12-12T12:26:54.205213Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:638: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [UpdateCompletness] took 4us
2025-12-12T12:26:54.205238Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:651: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [EliminateCommonSubExpressions] took 18us
2025-12-12T12:26:54.205268Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core] yql_out_transformers.cpp:62: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#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-12-12T12:26:54.205286Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core] yql_co_simple1.cpp:6478: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Drop Unordered over AsList
2025-12-12T12:26:54.205319Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-12-12T12:26:54.205336Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 10us
2025-12-12T12:26:54.205348Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_constraint.cpp:3307: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 5us
2025-12-12T12:26:54.205359Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:638: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [UpdateCompletness] took 4us
2025-12-12T12:26:54.205377Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:651: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [EliminateCommonSubExpressions] took 12us
2025-12-12T12:26:54.205404Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core] yql_out_transformers.cpp:62: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#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-12-12T12:26:54.205837Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core dq] dq_opt_phy_finalizing.cpp:488: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} DqReplicateStageMultiOutput: start traverse node #199947, Commit!
2025-12-12T12:26:54.205889Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [RESULT] yql_result_provider.cpp:802: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} ResFill
2025-12-12T12:26:54.205926Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-12-12T12:26:54.205953Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 21us
2025-12-12T12:26:54.205969Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_constraint.cpp:3307: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 8us
2025-12-12T12:26:54.205980Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:638: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [UpdateCompletness] took 4us
2025-12-12T12:26:54.206005Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.205 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:651: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution of [EliminateCommonSubExpressions] took 17us
2025-12-12T12:26:54.206037Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core] yql_out_transformers.cpp:62: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#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-12-12T12:26:54.206172Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core dq] dq_opt_phy_finalizing.cpp:488: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} DqReplicateStageMultiOutput: start traverse node #199951, Commit!
2025-12-12T12:26:54.206242Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:60: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Begin, root #199951
2025-12-12T12:26:54.206248Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:73: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Collect unused nodes for root #199951, status: Ok
2025-12-12T12:26:54.206255Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:410: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} {0}, callable #199951 <Commit!>
2025-12-12T12:26:54.206262Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:410: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} {1}, callable #199950 <ResFill!>
2025-12-12T12:26:54.206273Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:410: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} {2}, callable #199812 <Configure!>
2025-12-12T12:26:54.206282Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:410: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} {2}, callable #199812 <Configure!>
2025-12-12T12:26:54.206292Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:629: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Node #199812<Configure!> finished execution
2025-12-12T12:26:54.206300Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:646: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Node #199812<Configure!> created 0 trackable nodes: 
2025-12-12T12:26:54.206307Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:410: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} {1}, callable #199950 <ResFill!>
2025-12-12T12:26:54.206351Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [DQ] yql_dq_exectransformer.cpp:884: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} Executing Result (UniqueId=199960)
2025-12-12T12:26:54.206435Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core] type_ann_expr.cpp:159: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} Repeated callable stats:
ToStream=1

2025-12-12T12:26:54.206445Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} Execution of [TypeAnnotationTransformer::DoTransform] took 23us
2025-12-12T12:26:54.206454Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} Execution of [TypeAnnotationTransformer::DoTransform] took 1us
2025-12-12T12:26:54.206465Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_constraint.cpp:3307: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} Execution of [ConstraintTransformer::DoTransform] took 3us
2025-12-12T12:26:54.206475Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:638: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} Execution of [UpdateCompletness] took 2us
2025-12-12T12:26:54.206489Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:651: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} Execution of [EliminateCommonSubExpressionsForSubGraph] took 6us
2025-12-12T12:26:54.206508Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.206 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core peephole] yql_out_transformers.cpp:62: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} PeepHoleOpt:
(
(return (Iterator (AsList (AsStruct '('"column0" (Int32 '"42"))))))
)

2025-12-12T12:26:54.231400Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:54.231449Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582946929074637864:2204]
2025-12-12T12:26:54.231468Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:26:54.231484Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582946929074637865:2205]
2025-12-12T12:26:54.231503Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:54.231513Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:26:54.231517Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:54.231624Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:26:54.254397Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:26:54.254428Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=1/100 REFRESHED
2025-12-12T12:26:54.254457Z :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=1/100} SEND QUOTAS
2025-12-12T12:26:54.254477Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:26:54.254857Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:54.254917Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582946929074637870:2210]
2025-12-12T12:26:54.254933Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:26:54.254962Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:54.254973Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582946929074637871:2211]
2025-12-12T12:26:54.255039Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudq7ufppheikkkd58"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:26:54.259710Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:26:54.269337Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudq7ufppheikkkd58" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1765542413 nanos: 416891000 } modified_at { seconds: 1765542413 nanos: 416891000 } revision: 1 } execute_mode: RUN status: STARTING last_job_query_revision: 1 last_job_id: "ptjudq7ufpphdsf7akqv-ptqudq7ufppheikkkd58" started_by: "root@builtin" submitted_at { seconds: 1765542413 nanos: 416891000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "SELECT 42;" syntax: YQL_V1 } } } SUCCESS
2025-12-12T12:26:54.275401Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=1/100 NOTIFY CHANGE
2025-12-12T12:26:54.275441Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:26:54.279098Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542434 nanos: 195000000 } } SUCCESS
2025-12-12T12:26:54.279137Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Got CP::PingTaskResponse
2025-12-12T12:26:54.279532Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Ping response success: { expired_at { seconds: 1765542434 nanos: 195000000 } }
2025-12-12T12:26:54.279563Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Forward request Private::PingTask
2025-12-12T12:26:54.279580Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudq7ufppheikkkd58 Forward ping response. Success: 1. Cookie: 2
2025-12-12T12:26:54.280506Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Request CP::PingTask with size: 123 bytes
2025-12-12T12:26:54.280574Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f4"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
status: RUNNING
resources {
  rate_limiter: PREPARE
  compilation: PREPARE
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628813
  nanos: 995159000
}
tenant: "/default"
}
2025-12-12T12:26:54.283104Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.283 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core dq] dq_opt_phy_finalizing.cpp:488: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} DqReplicateStageMultiOutput: start traverse node #199962, Iterator
2025-12-12T12:26:54.283155Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.283 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core dq] dq_opt_build.cpp:235: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} [DQ/Build/TransformConsumers] (
(return (Iterator (AsList (AsStruct '('"column0" (Int32 '"42"))))))
)

2025-12-12T12:26:54.283184Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.283 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core dq] dq_opt_build.cpp:325: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} [DQ/Build/TransformPhysical] (
(return (Iterator (AsList (AsStruct '('"column0" (Int32 '"42"))))))
)

2025-12-12T12:26:54.283346Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.283 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] type_ann_expr.cpp:48: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} Execution of [TypeAnnotationTransformer::DoTransform] took 6us
2025-12-12T12:26:54.283365Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.283 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_constraint.cpp:3307: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} Execution of [ConstraintTransformer::DoTransform] took 3us
2025-12-12T12:26:54.283376Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.283 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:638: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} Execution of [UpdateCompletness] took 3us
2025-12-12T12:26:54.283396Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.283 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_expr_csee.cpp:651: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} Execution of [EliminateCommonSubExpressionsForSubGraph] took 11us
2025-12-12T12:26:54.283413Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.283 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core peephole] yql_out_transformers.cpp:62: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} PeepHoleOpt:
(
(return (Iterator (AsList (AsStruct '('"column0" (Int32 '"42"))))))
)

2025-12-12T12:26:54.283527Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.283 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [DQ] yql_dq_exectransformer.cpp:2098: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud/#199950/#199960} After PeepHole
(
(return (Iterator (AsList (AsStruct '('"column0" (Int32 '"42"))))))
)

2025-12-12T12:26:54.284327Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:928: QueryId: ptqudq7ufppheikkkd58 Graph (execution) with tasks: 1
2025-12-12T12:26:54.284401Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.284 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:518: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Register async execution for node #199950
2025-12-12T12:26:54.284427Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.284 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:88: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Finish, output #199951, status: Async
2025-12-12T12:26:54.284489Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.284 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:134: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Completed async execution for node #199950
2025-12-12T12:26:54.284503Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.284 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [DQ] yql_dq_exectransformer.cpp:1050: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud WrapFutureCallback
2025-12-12T12:26:54.284515Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.284 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [DQ] yql_dq_exectransformer.cpp:1053: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Execution Result complete, duration: 0.078156s
2025-12-12T12:26:54.284557Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.284 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:154: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} State is ExecutionComplete after apply async changes for node #199950
2025-12-12T12:26:54.284571Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.284 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:60: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Begin, root #199951
2025-12-12T12:26:54.284578Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.284 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:73: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Collect unused nodes for root #199951, status: Ok
2025-12-12T12:26:54.284585Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.284 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:410: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} {0}, callable #199951 <Commit!>
2025-12-12T12:26:54.284598Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.284 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:629: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Node #199951<Commit!> finished execution
2025-12-12T12:26:54.284618Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.284 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:646: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Node #199951<Commit!> created 0 trackable nodes: 
2025-12-12T12:26:54.284630Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.284 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:88: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Finish, output #199951, status: Ok
2025-12-12T12:26:54.284636Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.284 INFO  ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [core exec] yql_execution.cpp:94: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Creating finalizing transformer, output #199951
2025-12-12T12:26:54.284786Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:911: QueryId: ptqudq7ufppheikkkd58 Overall dq tasks: 1
2025-12-12T12:26:54.284806Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 78872d7c-df927b5a-4e4cc88f-87204a6f 2025-12-12 12:26:54.284 DEBUG ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [DQ] yql_dq_provider.cpp:126: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} CloseSession ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud
2025-12-12T12:26:54.284833Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 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-12-12T12:26:54.284901Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:758: QueryId: ptqudq7ufppheikkkd58 Graph 0
2025-12-12T12:26:54.284979Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Forward ping request: { result_set_count: 1 result_set_meta { column { name: "column0" type { type_id: INT32 } } } dq_graph: "\022\305\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(88a034dc314301cb1522a933e690a4c49a7591e8\032\023dq_vanilla_job.lite \002H\001RClocal/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiterZ)mock_cloud/my_folder/ptqudq7ufppheikkkd58`\200\200\200\200 \"\017\037\000\205\002\203\002\034column0/*\007column02qptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud:\024\n\017_LiteralTimeout\022\0010:\022\n\r_TableTimeout\022\0010:\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-12-12T12:26:54.301735Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542434 nanos: 292000000 } } SUCCESS
2025-12-12T12:26:54.301766Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Got CP::PingTaskResponse
2025-12-12T12:26:54.302195Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Ping response success: { expired_at { seconds: 1765542434 nanos: 292000000 } }
2025-12-12T12:26:54.302225Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Forward request Private::PingTask
2025-12-12T12:26:54.302227Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudq7ufppheikkkd58 Forward ping response. Success: 1. Cookie: 0
2025-12-12T12:26:54.302644Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Request CP::PingTask with size: 192 bytes
2025-12-12T12:26:54.302751Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f4"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
status: RUNNING
resources {
  rate_limiter: READY
  compilation: PREPARE
  rate_limiter_path: "local/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628813
  nanos: 995159000
}
tenant: "/default"
}
2025-12-12T12:26:54.317531Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542434 nanos: 308000000 } } SUCCESS
2025-12-12T12:26:54.317660Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Got CP::PingTaskResponse
2025-12-12T12:26:54.318159Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Ping response success: { expired_at { seconds: 1765542434 nanos: 308000000 } }
2025-12-12T12:26:54.318179Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Forward request Private::PingTask
2025-12-12T12:26:54.318197Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudq7ufppheikkkd58 Forward ping response. Success: 1. Cookie: 0
2025-12-12T12:26:54.318695Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Request CP::PingTask with size: 598 bytes
2025-12-12T12:26:54.318781Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f4"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
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: 1765628813
  nanos: 995159000
}
tenant: "/default"
}
2025-12-12T12:26:54.330799Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542434 nanos: 324000000 } } SUCCESS
2025-12-12T12:26:54.330922Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Got CP::PingTaskResponse
2025-12-12T12:26:54.331423Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Ping response success: { expired_at { seconds: 1765542434 nanos: 324000000 } }
2025-12-12T12:26:54.331451Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Forward request Private::PingTask
2025-12-12T12:26:54.331483Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudq7ufppheikkkd58 Forward ping response. Success: 1. Cookie: 0
2025-12-12T12:26:54.332024Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Request CP::PingTask with size: 1020 bytes
2025-12-12T12:26:54.332118Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f4"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
result_set_count: 1
result_set_meta {
  column {
    name: "column0"
    type {
      type_id: INT32
    }
  }
}
dq_graph: "\022\305\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(88a034dc314301cb1522a933e690a4c49a7591e8\032\023dq_vanilla_job.lite \002H\001RClocal/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiterZ)mock_cloud/my_folder/ptqudq7ufppheikkkd58`\200\200\200\200 \"\017\037\000\205\002\203\002\034column0/*\007column02qptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud:\024\n\017_LiteralTimeout\022\0010:\022\n\r_TableTimeout\022\0010:\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: 1765628813
  nanos: 995159000
}
tenant: "/default"
}
2025-12-12T12:26:54.350133Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542434 nanos: 338000000 } } SUCCESS
2025-12-12T12:26:54.350240Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Got CP::PingTaskResponse
2025-12-12T12:26:54.350706Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Ping response success: { expired_at { seconds: 1765542434 nanos: 338000000 } }
2025-12-12T12:26:54.350736Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudq7ufppheikkkd58 Forward ping response. Success: 1. Cookie: 1
2025-12-12T12:26:54.350753Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:911: QueryId: ptqudq7ufppheikkkd58 Overall dq tasks: 1
2025-12-12T12:26:54.351084Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.351 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] task_controller_impl.h:83: _AllResultsBytesLimit = 100000
2025-12-12T12:26:54.351094Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.351 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] task_controller_impl.h:86: _RowsLimitPerWrite = 1000
2025-12-12T12:26:54.351137Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1652: QueryId: ptqudq7ufppheikkkd58 Executer: [1:7582946929074637885:2225], Controller: [1:7582946929074637888:2228], ResultIdActor: [1:7582946929074637886:2226]
2025-12-12T12:26:54.351163Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.351 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] executer_actor.cpp:140: {ptqudq7ufppheikkkd58} TDqExecuter::OnGraph
2025-12-12T12:26:54.351179Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.351 INFO  ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] executer_actor.cpp:157: {ptqudq7ufppheikkkd58} Trying to allocate 1 workers [EnableComputeActor=1]
2025-12-12T12:26:54.351275Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.351 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] executer_actor.cpp:247: {ptqudq7ufppheikkkd58} Dq timeouts are set to: 0.000000s (global), 600.000000s (workers allocation fail), 30.000000s (workers allocation warn) 
2025-12-12T12:26:54.351289Z :FQ_RESULT_WRITER INFO: result_writer.cpp:62: TraceId: ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud Bootstrap
2025-12-12T12:26:54.351348Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Forward ping request: { owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f4" query_id { value: "ptqudq7ufppheikkkd58" } 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_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter" } scope: "yandexcloud://my_folder" }
2025-12-12T12:26:54.351350Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Forward request Private::PingTask
2025-12-12T12:26:54.352192Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:125: TEvAllocateWorkersResponse Nodes {
  ResourceId: 4294967297
  Worker {
    NodeId: 1
    Guid: "cd1ef00f-46633fc8-ba674b4-747e39e0,ghrun-fhkyrtz6p4"
  }
}
2025-12-12T12:26:54.352713Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.352 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] executer_actor.cpp:358: {ptqudq7ufppheikkkd58} TDqExecuter::TEvAllocateWorkersResponse
2025-12-12T12:26:54.352722Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.352 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] executer_actor.cpp:384: {ptqudq7ufppheikkkd58} Allocated resource 4294967297
2025-12-12T12:26:54.352750Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.352 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] executer_actor.cpp:401: {ptqudq7ufppheikkkd58} WorkerInfo: Id:cd1ef00f-46633fc8-ba674b4-747e39e0,ghrun-fhkyrtz6p4,NodeId:1,StageId:1
2025-12-12T12:26:54.352757Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.352 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] executer_actor.cpp:402: {ptqudq7ufppheikkkd58} TaskInfo: 0/1
2025-12-12T12:26:54.352763Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.352 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] executer_actor.cpp:404: {ptqudq7ufppheikkkd58}  ObjectId: 88a034dc314301cb1522a933e690a4c49a7591e8, dq_vanilla_job.lite, 
2025-12-12T12:26:54.352776Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.352 INFO  ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] executer_actor.cpp:415: {ptqudq7ufppheikkkd58} 1 workers allocated
2025-12-12T12:26:54.352838Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud 2025-12-12 12:26:54.352 TRACE ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] task_controller_impl.h:271: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud}  [1:7582946929074637888:2228] ExportStats Summary
2025-12-12T12:26:54.352861Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud 2025-12-12 12:26:54.352 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] task_controller_impl.h:526: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Ready State: [1:7582946929074637888:2228]
2025-12-12T12:26:54.352870Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud 2025-12-12 12:26:54.352 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] task_controller_impl.h:537: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Forward: [1:7582946929074637888:2228] to [1:7582946929074637887:2227]
2025-12-12T12:26:54.352898Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:70: [ptqudq7ufppheikkkd58-0.1] TEvReadyState, streaming disposition { fresh { } }, state load mode EMPTY, checkpointing period 1.000000s
2025-12-12T12:26:54.352907Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:104: [ptqudq7ufppheikkkd58-0.1] AllActors count: 1, ActorsToTrigger count: 0, ActorsToNotify count: 0, ActorsToWaitFor count: 0
2025-12-12T12:26:54.352909Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:107: [ptqudq7ufppheikkkd58-0.1] No ingress tasks, coordinator was disabled
2025-12-12T12:26:54.352910Z :STREAMS_CHECKPOINT_COORDINATOR INFO: checkpoint_coordinator.cpp:445: [ptqudq7ufppheikkkd58-0.1] Send TEvRun to all actors
2025-12-12T12:26:54.352920Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:144: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Start compute actor [1:7582946929074637890:2230], task: 1
2025-12-12T12:26:54.352942Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:114: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Use CPU quota: 1. Rate limiter resource: { "local/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter", "mock_cloud/my_folder/ptqudq7ufppheikkkd58" }
2025-12-12T12:26:54.355676Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Request CP::PingTask with size: 213 bytes
2025-12-12T12:26:54.355772Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f4"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
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_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628813
  nanos: 995159000
}
tenant: "/default"
}
2025-12-12T12:26:54.360026Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1164: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Got TEvRun from actor [1:7582946929074637887:2227]
2025-12-12T12:26:54.360046Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Poll inputs
2025-12-12T12:26:54.360048Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1498: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Poll sources
2025-12-12T12:26:54.360050Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. DoExecuteImpl: 0
2025-12-12T12:26:54.360113Z :KQP_COMPUTE TRACE: dq_compute_memory_quota.h:97: TxId: ptqudq7ufppheikkkd58, task: 1. Peak memory usage: 196608
2025-12-12T12:26:54.360119Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. update task runner stats
2025-12-12T12:26:54.360137Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Resume execution, run status: Finished checkpoint: 0 watermark injected: (empty maybe)
2025-12-12T12:26:54.360140Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-12T12:26:54.360144Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:422: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Can not drain channelId: 1, no dst actor id
2025-12-12T12:26:54.360149Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:515: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Continue execution, either output buffers are not empty or not all channels are ready, hasDataToSend: 1, channelsReady: 0
2025-12-12T12:26:54.360184Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud 2025-12-12 12:26:54.360 TRACE ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] task_controller_impl.h:160: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} [1:7582946929074637888:2228] EvState TaskId: 1 State: 2 PingCookie: 0 StatusCode: UNSPECIFIED
2025-12-12T12:26:54.360194Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud 2025-12-12 12:26:54.360 TRACE ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] task_controller_impl.h:201: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud}  [1:7582946929074637888:2228] Executing TaskId: 1
2025-12-12T12:26:54.360220Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud 2025-12-12 12:26:54.360 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] task_controller_impl.h:561: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} Update channels
2025-12-12T12:26:54.362281Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud 2025-12-12 12:26:54.360 TRACE ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] task_controller_impl.h:577: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} 1 Update { Id: 1 SrcTaskId: 2 DstTaskId: 1 SrcEndpoint { ActorId { RawX1: 0 RawX2: 0 } } DstEndpoint { ActorId { RawX1: 7582946929074637886 RawX2: 4503603922340018 } } SrcStageId: 1 }
2025-12-12T12:26:54.362329Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1064: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Received channels info: Update { Id: 1 SrcTaskId: 2 DstTaskId: 1 SrcEndpoint { ActorId { RawX1: 0 RawX2: 0 } } DstEndpoint { ActorId { RawX1: 7582946929074637886 RawX2: 4503603922340018 } } SrcStageId: 1 }
2025-12-12T12:26:54.362333Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1083: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Update output channelId: 1, peer: [1:7582946929074637886:2226]
2025-12-12T12:26:54.362340Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Poll inputs
2025-12-12T12:26:54.362343Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1498: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Poll sources
2025-12-12T12:26:54.362345Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. DoExecuteImpl: 0
2025-12-12T12:26:54.362412Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. update task runner stats
2025-12-12T12:26:54.362439Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Resume execution, run status: Finished checkpoint: 0 watermark injected: (empty maybe)
2025-12-12T12:26:54.362442Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-12T12:26:54.362448Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. About to drain channelId: 1, hasPeer: 1, peerState:(freeSpace:1000000;inFlightBytes:0;inFlightCount:0;)
2025-12-12T12:26:54.362493Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:566: TxId: ptqudq7ufppheikkkd58, task: 1. SendChannelData, channelId: 1, peer: [1:7582946929074637886:2226], chunks: 1, bytes: 3, watermark: 0, checkpoint: 0, seqNo: 1, finished: 1
2025-12-12T12:26:54.362509Z :KQP_COMPUTE DEBUG: dq_compute_actor_channels.cpp:669: TxId: ptqudq7ufppheikkkd58, task: 1. Tasks execution finished, waiting for chunk delivery in output channelId: 1, seqNo: [1]
2025-12-12T12:26:54.364428Z :YQL_PRIVATE_PROXY DEBUG: task_result_write.cpp:79: PrivateWriteTask - ResultId: ptrudq7ufp5s91uul840, RequestId: 0,  Request CP::WriteTaskResult with size: 102 bytes
2025-12-12T12:26:54.364458Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_result_write.cpp:33: WriteResultDataRequest: ptrudq7ufp5s91uul840 0 0 24 2025-12-13T12:26:53.995159Z
2025-12-12T12:26:54.371766Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542434 nanos: 364000000 } } SUCCESS
2025-12-12T12:26:54.371796Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Got CP::PingTaskResponse
2025-12-12T12:26:54.372440Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Ping response success: { expired_at { seconds: 1765542434 nanos: 364000000 } }
2025-12-12T12:26:54.372466Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudq7ufppheikkkd58 Forward ping response. Success: 1. Cookie: 0
2025-12-12T12:26:54.391729Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: WriteResultDataRequest - WriteResultDataResult: {} SUCCESS
2025-12-12T12:26:54.391791Z :YQL_PRIVATE_PROXY DEBUG: task_result_write.cpp:94: PrivateWriteTask - ResultId: ptrudq7ufp5s91uul840, RequestId: 0,  Got CP::WriteTaskResult Response
2025-12-12T12:26:54.392236Z :FQ_RESULT_WRITER TRACE: result_writer.cpp:175: TraceId: ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud ChannelData, Records: 1 HasError: 0 Size: 3 Rows: 1 FreeSpace: 67108864 Duration: 0.041262s AvgSpeed: 0
2025-12-12T12:26:54.392256Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:179: TxId: ptqudq7ufppheikkkd58, task: 1. Received channel data ack for channelId: 1, seqNo: 1, lastSentSeqNo: 1, freeSpace: 67108864, early finish: 0
2025-12-12T12:26:54.392267Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:207: TxId: ptqudq7ufppheikkkd58, task: 1. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 1, ackSeqNo: 1
2025-12-12T12:26:54.392268Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:220: TxId: ptqudq7ufppheikkkd58, task: 1. Resume compute actor
2025-12-12T12:26:54.392284Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Poll inputs
2025-12-12T12:26:54.392288Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1498: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Poll sources
2025-12-12T12:26:54.392290Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. DoExecuteImpl: 0
2025-12-12T12:26:54.392373Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. update task runner stats
2025-12-12T12:26:54.392399Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Resume execution, run status: Finished checkpoint: 0 watermark injected: (empty maybe)
2025-12-12T12:26:54.392402Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-12T12:26:54.392405Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:436: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Do not drain channelId: 1, finished
2025-12-12T12:26:54.392409Z :KQP_COMPUTE DEBUG: dq_compute_actor_channels.cpp:674: TxId: ptqudq7ufppheikkkd58, task: 1. Tasks execution finished
2025-12-12T12:26:54.392412Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:523: SelfId: [1:7582946929074637890:2230], TxId: ptqudq7ufppheikkkd58, task: 1. Ctx: {}. Compute state finished. All channels and sinks finished
2025-12-12T12:26:54.392437Z :KQP_COMPUTE DEBUG: dq_compute_actor_channels.cpp:494: TxId: ptqudq7ufppheikkkd58, task: 1. pass away
2025-12-12T12:26:54.392685Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud 2025-12-12 12:26:54.392 TRACE ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] task_controller_impl.h:160: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud} [1:7582946929074637888:2228] EvState TaskId: 1 State: 3 PingCookie: 0 StatusCode: SUCCESS
2025-12-12T12:26:54.392697Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud 2025-12-12 12:26:54.392 TRACE ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] task_controller_impl.h:174: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud}  [1:7582946929074637888:2228] AddStats 1
2025-12-12T12:26:54.392753Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud 2025-12-12 12:26:54.392 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] task_controller_impl.h:212: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud}  [1:7582946929074637888:2228] Finish TaskId: 1. Tasks finished: 1/1
2025-12-12T12:26:54.392895Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud 2025-12-12 12:26:54.392 TRACE ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] task_controller_impl.h:271: {ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud}  [1:7582946929074637888:2228] ExportStats Summary
2025-12-12T12:26:54.393380Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.393 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] executer_actor.cpp:324: {ptqudq7ufppheikkkd58} OnGraphFinished
2025-12-12T12:26:54.393391Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.393 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] executer_actor.cpp:284: {ptqudq7ufppheikkkd58} Finish with status=1 issues=
2025-12-12T12:26:54.393568Z :FQ_RESULT_WRITER DEBUG: result_writer.cpp:126: TraceId: ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud Send response to executer
2025-12-12T12:26:54.393590Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:54.393 DEBUG ydbd(pid=1185214, tid=0x00007F5BC7A60640) [DQ] executer_actor.cpp:341: {ptqudq7ufppheikkkd58} OnQueryResponse status=1 issuses_size=0
2025-12-12T12:26:54.393620Z :FQ_RESULT_WRITER INFO: result_writer.cpp:87: TraceId: ptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud FinishWrite, Records: 1 HasError: 0 Size: 3 Rows: 1 FreeSpace: 67108864 Duration: 0.042652s AvgSpeed: 0 ResultChunks.size(): 0
2025-12-12T12:26:54.393643Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1233: QueryId: ptqudq7ufppheikkkd58 Query response SUCCESS. Result set index: 0. Issues count: 0. Rows count: 1
2025-12-12T12:26:54.394054Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1827: QueryId: ptqudq7ufppheikkkd58 Is about to finish query with status COMPLETED
2025-12-12T12:26:54.394059Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1820: QueryId: ptqudq7ufppheikkkd58 Write finalizing status: COMPLETING
2025-12-12T12:26:54.394107Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Forward ping request: { status: COMPLETING }
2025-12-12T12:26:54.394111Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Forward request Private::PingTask
2025-12-12T12:26:54.394714Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:657: [ptqudq7ufppheikkkd58-0.1] PassAway
2025-12-12T12:26:54.395418Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Request CP::PingTask with size: 116 bytes
2025-12-12T12:26:54.395508Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f4"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
status: COMPLETING
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628813
  nanos: 995159000
}
tenant: "/default"
}
2025-12-12T12:26:54.406159Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542434 nanos: 401000000 } } SUCCESS
2025-12-12T12:26:54.406225Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Got CP::PingTaskResponse
2025-12-12T12:26:54.406543Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Ping response success: { expired_at { seconds: 1765542434 nanos: 401000000 } }
2025-12-12T12:26:54.406569Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:880: QueryId: ptqudq7ufppheikkkd58 Forward ping response. Success: 1. Cookie: 3
2025-12-12T12:26:54.406572Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:887: QueryId: ptqudq7ufppheikkkd58 Finalizing status is saved
2025-12-12T12:26:54.406576Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1507: QueryId: ptqudq7ufppheikkkd58 Start rate limiter resource deleter
2025-12-12T12:26:54.407099Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:175: PrivateDeleteRateLimiterResource - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Request CP::DeleteRateLimiterResource with size: 97 bytes
2025-12-12T12:26:54.407139Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: DeleteRateLimiterResourceRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f4"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
scope: "yandexcloud://my_folder"
tenant: "/default"
} 
2025-12-12T12:26:54.443237Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: DeleteRateLimiterResourceRequest. Got response from database: SUCCESS
2025-12-12T12:26:54.443341Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run delete rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58" actor
2025-12-12T12:26:54.443345Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call delete rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58"
2025-12-12T12:26:54.445246Z :YQ_RATE_LIMITER DEBUG: schema.cpp:179: Successfully deleted rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58"
2025-12-12T12:26:54.445253Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for delete rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58": 
2025-12-12T12:26:54.445283Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:219: Got delete response from rate limiter service
2025-12-12T12:26:54.445302Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:199: PrivateDeleteRateLimiterResource - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Got CP::DeleteRateLimiterResourceResponse
2025-12-12T12:26:54.445603Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1498: QueryId: ptqudq7ufppheikkkd58 Rate limiter resource deletion finished. Success: 1. Issues: 
2025-12-12T12:26:54.445607Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1919: QueryId: ptqudq7ufppheikkkd58 SendPingAndPassAway, FinalQueryStatus COMPLETED
2025-12-12T12:26:54.445624Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:536: QueryId: ptqudq7ufppheikkkd58 PassAway
2025-12-12T12:26:54.445865Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Forward ping request: { owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f4" query_id { value: "ptqudq7ufppheikkkd58" } result_id { value: "ptrudq7ufp5s91uul840" } status: COMPLETED result_set_count: 1 statistics: "{\"Graph=0\":{\"Actor\":{\"ActorCreateTimeUs\":{\"sum\":\"188us\",\"count\":1,\"avg\":\"188us\",\"max\":\"188us\",\"min\":\"188us\"}},\"AllocateWorkersUs\":{\"sum\":\"1ms\",\"count\":1,\"avg\":\"1ms\",\"max\":\"1ms\",\"min\":\"1ms\"},\"ExecutionTimeUs\":{\"sum\":\"40ms\",\"count\":1,\"avg\":\"40ms\",\"max\":\"40ms\",\"min\":\"40ms\"},\"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\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"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\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"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\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"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\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"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\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"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\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"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\":\"6ms\",\"count\":1,\"avg\":\"6ms\",\"max\":\"6ms\",\"min\":\"6ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"51us\",\"count\":1,\"avg\":\"51us\",\"max\":\"51us\",\"min\":\"51us\"},\"CpuTimeUs\":{\"sum\":\"7ms\",\"count\":1,\"avg\":\"7ms\",\"max\":\"7ms\",\"min\":\"7ms\"},\"FinishTimeMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.39s\",\"max\":\"12:26:54.39s\",\"min\":\"12:26:54.39s\"},\"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\":\"6ms\",\"count\":1,\"avg\":\"6ms\",\"max\":\"6ms\",\"min\":\"6ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"51us\",\"count\":1,\"avg\":\"51us\",\"max\":\"51us\",\"min\":\"51us\"},\"CpuTimeUs\":{\"sum\":\"7ms\",\"count\":1,\"avg\":\"7ms\",\"max\":\"7ms\",\"min\":\"7ms\"},\"FinishTimeMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.39s\",\"max\":\"12:26:54.39s\",\"min\":\"12:26:54.39s\"},\"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_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter" } scope: "yandexcloud://my_folder" finished_at { seconds: 1765542414 nanos: 394000000 } }
2025-12-12T12:26:54.445867Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Forward request Private::PingTask
2025-12-12T12:26:54.446263Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Request CP::PingTask with size: 5641 bytes
2025-12-12T12:26:54.446346Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f4"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
result_id {
  value: "ptrudq7ufp5s91uul840"
}
status: COMPLETED
result_set_count: 1
statistics: "{\"Graph=0\":{\"Actor\":{\"ActorCreateTimeUs\":{\"sum\":\"188us\",\"count\":1,\"avg\":\"188us\",\"max\":\"188us\",\"min\":\"188us\"}},\"AllocateWorkersUs\":{\"sum\":\"1ms\",\"count\":1,\"avg\":\"1ms\",\"max\":\"1ms\",\"min\":\"1ms\"},\"ExecutionTimeUs\":{\"sum\":\"40ms\",\"count\":1,\"avg\":\"40ms\",\"max\":\"40ms\",\"min\":\"40ms\"},\"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\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"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\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"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\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"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\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"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\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"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\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.36s\",\"max\":\"12:26:54.36s\",\"min\":\"12:26:54.36s\"},\"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\":\"6ms\",\"count\":1,\"avg\":\"6ms\",\"max\":\"6ms\",\"min\":\"6ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"51us\",\"count\":1,\"avg\":\"51us\",\"max\":\"51us\",\"min\":\"51us\"},\"CpuTimeUs\":{\"sum\":\"7ms\",\"count\":1,\"avg\":\"7ms\",\"max\":\"7ms\",\"min\":\"7ms\"},\"FinishTimeMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.39s\",\"max\":\"12:26:54.39s\",\"min\":\"12:26:54.39s\"},\"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\":\"6ms\",\"count\":1,\"avg\":\"6ms\",\"max\":\"6ms\",\"min\":\"6ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"51us\",\"count\":1,\"avg\":\"51us\",\"max\":\"51us\",\"min\":\"51us\"},\"CpuTimeUs\":{\"sum\":\"7ms\",\"count\":1,\"avg\":\"7ms\",\"max\":\"7ms\",\"min\":\"7ms\"},\"FinishTimeMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:26:54.39s\",\"max\":\"12:26:54.39s\",\"min\":\"12:26:54.39s\"},\"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_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter"
}
scope: "yandexcloud://my_folder"
finished_at {
  seconds: 1765542414
  nanos: 394000000
}
deadline {
  seconds: 1765628813
  nanos: 995159000
}
tenant: "/default"
}
2025-12-12T12:26:54.567475Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {} SUCCESS
2025-12-12T12:26:54.567580Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4, Got CP::PingTaskResponse
2025-12-12T12:26:54.567910Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Ping response success: {  }
2025-12-12T12:26:54.567925Z :FQ_PINGER DEBUG: pinger.cpp:379: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Query finished
2025-12-12T12:26:54.567928Z :FQ_PINGER TRACE: pinger.cpp:187: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f4 Stop Pinger
2025-12-12T12:26:54.772132Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:54.772183Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582946929074637913:2250]
2025-12-12T12:26:54.772206Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:26:54.772246Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582946929074637914:2251]
2025-12-12T12:26:54.772289Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:54.772305Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:26:54.772318Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:54.772364Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:26:54.774914Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:26:54.774951Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=0/100 REFRESHED
2025-12-12T12:26:54.774973Z :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-12-12T12:26:54.774996Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:26:54.775042Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:54.775099Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582946929074637919:2256]
2025-12-12T12:26:54.775120Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:26:54.775151Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:54.775193Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582946929074637920:2257]
2025-12-12T12:26:54.775252Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudq7ufppheikkkd58"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:26:54.777447Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudq7ufppheikkkd58" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1765542413 nanos: 416891000 } modified_at { seconds: 1765542413 nanos: 416891000 } revision: 1 } started_at { seconds: 1765542414 nanos: 61000000 } finished_at { seconds: 1765542414 nanos: 394000000 } execute_mode: RUN status: COMPLETED last_job_query_revision: 1 last_job_id: "ptjudq7ufpphdsf7akqv-ptqudq7ufppheikkkd58" result_expire_at { seconds: 1765628813 nanos: 995159000 } started_by: "root@builtin" submitted_at { seconds: 1765542413 nanos: 416891000 } } content { type: STREAMING 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\":\"7ms\",\"count\":1,\"avg\":\"7ms\",\"max\":\"7ms\",\"min\":\"7ms\"},\"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-12-12T12:26:54.778520Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:26:54.780433Z :TICKET_PARSER DEBUG: ticket_parser_impl.h:1875: Ticket **** (B6C6F477) (ipv6:[::1]:53876) has now valid token of root@builtin
2025-12-12T12:26:54.780550Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:918: ModifyQueryRequest: query_id: "ptqudq7ufppheikkkd58"
content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  text: "blablabla"
}
execute_mode: RUN
state_load_mode: EMPTY
2025-12-12T12:26:54.780586Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582946929074637924:2260]
2025-12-12T12:26:54.780609Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:26:54.780622Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582946929074637925:2261]
2025-12-12T12:26:54.780638Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:54.780646Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:26:54.780652Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:54.780706Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:26:54.782207Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:26:54.782273Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:26:54.782546Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:26:54.782569Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=0/100 REFRESHED
2025-12-12T12:26:54.782590Z :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-12-12T12:26:54.782601Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:26:54.782646Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:918: ModifyQueryRequest: query_id: "ptqudq7ufppheikkkd58"
content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  text: "blablabla"
}
execute_mode: RUN
state_load_mode: EMPTY
2025-12-12T12:26:54.782725Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582946929074637930:2266]
2025-12-12T12:26:54.782758Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:26:54.782793Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:918: ModifyQueryRequest: query_id: "ptqudq7ufppheikkkd58"
content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  text: "blablabla"
}
execute_mode: RUN
state_load_mode: EMPTY
2025-12-12T12:26:54.782817Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:435: Create database bootstrap. CloudId: mock_cloud Scope: yandexcloud://my_folder Actor id: [1:7582946929074637931:2267]
2025-12-12T12:26:54.782844Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:918: ModifyQueryRequest: query_id: "ptqudq7ufppheikkkd58"
content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  text: "blablabla"
}
execute_mode: RUN
state_load_mode: EMPTY
2025-12-12T12:26:54.782868Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582946929074637932:2268]
2025-12-12T12:26:54.782955Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:812: ModifyQueryRequest: {query_id: "ptqudq7ufppheikkkd58"
content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  text: "blablabla"
}
execute_mode: RUN
state_load_mode: EMPTY
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:26:54.788300Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:26:54.788611Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:26:54.788793Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:26:54.914418Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7582946911894768535:2081]
2025-12-12T12:26:54.914442Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-12T12:26:54.914486Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:356: Coordinator: TEvPing received, [1:7582946911894768519:2069]
2025-12-12T12:26:54.914490Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [1:7582946911894768519:2069]
2025-12-12T12:26:54.914493Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:359: Coordinator: Send TEvPong to [1:7582946911894768519:2069]
2025-12-12T12:26:54.914499Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-12T12:26:54.916282Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f6, Host: ghrun-fhkyrtz6p4, Tenant: /default
2025-12-12T12:26:54.919130Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f6, Host: ghrun-fhkyrtz6p4, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-12-12T12:26:54.919177Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f6"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:26:54.923590Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:26:54.923641Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f6, Host: ghrun-fhkyrtz6p4, Tenant: /default, Got CP::GetTask Response
2025-12-12T12:26:54.924075Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-12T12:26:54.924082Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-12T12:26:55.165379Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: ModifyQueryRequest - ModifyQueryResult: {} SUCCESS
2025-12-12T12:26:55.168221Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:55.168283Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582946933369605235:2274]
2025-12-12T12:26:55.168312Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:26:55.168336Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582946933369605236:2275]
2025-12-12T12:26:55.168362Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:55.168376Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:26:55.168387Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:55.168417Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:26:55.179713Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:26:55.179740Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=1/100 REFRESHED
2025-12-12T12:26:55.179763Z :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=1/100} SEND QUOTAS
2025-12-12T12:26:55.179771Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:26:55.179801Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:55.179855Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582946933369605241:2280]
2025-12-12T12:26:55.179884Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:26:55.179903Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:55.179913Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582946933369605242:2281]
2025-12-12T12:26:55.179940Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudq7ufppheikkkd58"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:26:55.180856Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:26:55.183440Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudq7ufppheikkkd58" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1765542413 nanos: 416891000 } modified_at { seconds: 1765542414 nanos: 966327000 } revision: 2 } execute_mode: RUN status: STARTING last_job_query_revision: 2 last_job_id: "ptjudq7ufoa8d285dv2o-ptqudq7ufppheikkkd58" started_by: "root@builtin" submitted_at { seconds: 1765542414 nanos: 966327000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } text: "blablabla" } } } SUCCESS
2025-12-12T12:26:55.188266Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:26:55.188321Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=1/100 NOTIFY CHANGE
2025-12-12T12:26:55.687263Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:55.687313Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582946933369605246:2284]
2025-12-12T12:26:55.687346Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:26:55.687376Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582946933369605247:2285]
2025-12-12T12:26:55.687427Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:55.687455Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:26:55.687470Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:55.687504Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:26:55.695536Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:26:55.695559Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=1/100 REFRESHED
2025-12-12T12:26:55.695581Z :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=1/100} SEND QUOTAS
2025-12-12T12:26:55.695597Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:26:55.695634Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:55.695689Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582946933369605252:2290]
2025-12-12T12:26:55.695733Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:26:55.695774Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:55.695819Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582946933369605253:2291]
2025-12-12T12:26:55.695863Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudq7ufppheikkkd58"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:26:55.697423Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:26:55.698207Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudq7ufppheikkkd58" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1765542413 nanos: 416891000 } modified_at { seconds: 1765542414 nanos: 966327000 } revision: 2 } execute_mode: RUN status: STARTING last_job_query_revision: 2 last_job_id: "ptjudq7ufoa8d285dv2o-ptqudq7ufppheikkkd58" started_by: "root@builtin" submitted_at { seconds: 1765542414 nanos: 966327000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } text: "blablabla" } } } SUCCESS
2025-12-12T12:26:55.701994Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=1/100 NOTIFY CHANGE
2025-12-12T12:26:55.702154Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:26:55.910058Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-12-12T12:26:55.910058Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:665: Coordinator: Change global state to Started (by timeout)
2025-12-12T12:26:55.910967Z :YQ_CONTROL_PLANE_STORAGE TRACE: nodes_health_check.cpp:38: NodesHealthCheckRequest: {tenant: "/default"
node {
  node_id: 1
  instance_id: "cd1ef00f-46633fc8-ba674b4-747e39e0"
  hostname: "ghrun-fhkyrtz6p4"
  interconnect_port: 18528
  node_address: "127.0.1.1"
}
}
2025-12-12T12:26:55.917233Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7, Host: ghrun-fhkyrtz6p4, Tenant: /default
2025-12-12T12:26:55.917883Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7, Host: ghrun-fhkyrtz6p4, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-12-12T12:26:55.917951Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f7"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:26:55.920907Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:463: Task (Query): ptqudq7ufppheikkkd58 RetryRate: 0 RetryCounter: 0 At: 2025-12-12T12:26:54.966482Z
2025-12-12T12:26:55.931230Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {tasks { query_id { value: "ptqudq7ufppheikkkd58" } job_id { value: "ptjudq7ufoa8d285dv2o" } generation: 2 streaming: true dq_graph: "\022\305\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(88a034dc314301cb1522a933e690a4c49a7591e8\032\023dq_vanilla_job.lite \002H\001RClocal/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiterZ)mock_cloud/my_folder/ptqudq7ufppheikkkd58`\200\200\200\200 \"\017\037\000\205\002\203\002\034column0/*\007column02qptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud:\024\n\017_LiteralTimeout\022\0010:\022\n\r_TableTimeout\022\0010:\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: STREAMING 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: 1765628815 nanos: 925330000 } disposition { fresh { } } result_limit: 20971520 execution_limit { } request_started_at { } resources { } compute_connection { } result_ttl { seconds: 86400 } request_submitted_at { seconds: 1765542414 nanos: 966327000 } } } SUCCESS
2025-12-12T12:26:55.931290Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7, Host: ghrun-fhkyrtz6p4, Tenant: /default, Got CP::GetTask Response
2025-12-12T12:26:55.931786Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-12T12:26:55.931793Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 1
2025-12-12T12:26:55.931807Z :FQ_PENDING_FETCHER DEBUG: pending_fetcher.cpp:361: NewTask: Scope: yandexcloud://my_folder Id: ptqudq7ufppheikkkd58 UserId: root@builtin AuthToken: **** (B6C6F477)
2025-12-12T12:26:55.931940Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f8, Host: ghrun-fhkyrtz6p4, Tenant: /default
2025-12-12T12:26:55.931941Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:375: QueryId: ptqudq7ufppheikkkd58 Start run actor. Compute state: STARTING
2025-12-12T12:26:55.931944Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:469: QueryId: ptqudq7ufppheikkkd58 FillConnections
2025-12-12T12:26:55.931982Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:2333: QueryId: ptqudq7ufppheikkkd58 Run actors params: { QueryId: ptqudq7ufppheikkkd58 CloudId: mock_cloud UserId: root@builtin Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 PreviousQueryRevision: 2 Connections: 0 Bindings: 0 AccountIdSignatures: 0 QueryType: STREAMING ExecuteMode: RUN ResultId: ptrudq7ufncphnrfk6bq StateLoadMode: EMPTY StreamingDisposition: { fresh { } } Status: STARTING DqGraphs: 1 DqGraphIndex: 0 Resource.TopicConsumers: 0 }
2025-12-12T12:26:55.932004Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:571: QueryId: ptqudq7ufppheikkkd58 Start rate limiter resource creator
2025-12-12T12:26:55.932005Z :FQ_PINGER TRACE: pinger.cpp:171: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Start Pinger
2025-12-12T12:26:55.932027Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Forward ping request: { started_at { seconds: 1765542415 nanos: 931000000 } }
2025-12-12T12:26:55.932032Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Forward request Private::PingTask
2025-12-12T12:26:55.932052Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Forward ping request: { status: RUNNING resources { rate_limiter: PREPARE compilation: PREPARE } }
2025-12-12T12:26:55.932400Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f8, Host: ghrun-fhkyrtz6p4, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-12-12T12:26:55.932440Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f8"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:26:55.932494Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:78: PrivateCreateRateLimiterResource - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7, Request CP::CreateRateLimiterResource with size: 97 bytes
2025-12-12T12:26:55.932512Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7, Request CP::PingTask with size: 129 bytes
2025-12-12T12:26:55.932528Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: CreateRateLimiterResourceRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f7"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
scope: "yandexcloud://my_folder"
tenant: "/default"
} 
2025-12-12T12:26:55.932566Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f7"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
scope: "yandexcloud://my_folder"
started_at {
  seconds: 1765542415
  nanos: 931000000
}
deadline {
  seconds: 1765628815
  nanos: 925330000
}
tenant: "/default"
}
2025-12-12T12:26:55.935150Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:26:55.935212Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f8, Host: ghrun-fhkyrtz6p4, Tenant: /default, Got CP::GetTask Response
2025-12-12T12:26:55.935485Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-12T12:26:55.935489Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-12T12:26:55.935490Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: CreateRateLimiterResourceRequest. Got response from database: SUCCESS
2025-12-12T12:26:55.935581Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58" actor
2025-12-12T12:26:55.935583Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58"
2025-12-12T12:26:55.937071Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58"
2025-12-12T12:26:55.937076Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58": 
2025-12-12T12:26:55.937101Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:180: Got create response from rate limiter service
2025-12-12T12:26:55.937122Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:102: PrivateCreateRateLimiterResource - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7, Got CP::CreateRateLimiterResourceResponse
2025-12-12T12:26:55.937474Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1476: QueryId: ptqudq7ufppheikkkd58 Rate limiter resource creation finished. Success: 1
2025-12-12T12:26:55.937489Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1966: QueryId: ptqudq7ufppheikkkd58 Compiling query ...
2025-12-12T12:26:55.937528Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Forward ping request: { status: RUNNING resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter" } }
2025-12-12T12:26:55.938004Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudq7ufppheikkkd58 2025-12-12 12:26:55.937 TRACE ydbd(pid=1185214, tid=0x00007F5BC6A5E640) [perf] yql_facade.cpp:855: Execution of [ParseSql] took 324us
2025-12-12T12:26:55.938051Z :FQ_RUN_ACTOR WARN: run_actor.cpp:1914: QueryId: ptqudq7ufppheikkkd58 ResignQuery, status ABORTED
2025-12-12T12:26:55.938056Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1919: QueryId: ptqudq7ufppheikkkd58 SendPingAndPassAway, FinalQueryStatus COMPUTE_STATUS_UNSPECIFIED
2025-12-12T12:26:55.938067Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Forward ping request: {  }
2025-12-12T12:26:55.938073Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:536: QueryId: ptqudq7ufppheikkkd58 PassAway
2025-12-12T12:26:55.938135Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Forward ping request: { owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f7" query_id { value: "ptqudq7ufppheikkkd58" } 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_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter" } scope: "yandexcloud://my_folder" }
2025-12-12T12:26:55.944205Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542435 nanos: 938000000 } } SUCCESS
2025-12-12T12:26:55.944241Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7, Got CP::PingTaskResponse
2025-12-12T12:26:55.944683Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Ping response success: { expired_at { seconds: 1765542435 nanos: 938000000 } }
2025-12-12T12:26:55.944698Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Forward request Private::PingTask
2025-12-12T12:26:55.945144Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7, Request CP::PingTask with size: 123 bytes
2025-12-12T12:26:55.945227Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f7"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
status: RUNNING
resources {
  rate_limiter: PREPARE
  compilation: PREPARE
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628815
  nanos: 925330000
}
tenant: "/default"
}
2025-12-12T12:26:55.955397Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542435 nanos: 950000000 } } SUCCESS
2025-12-12T12:26:55.955486Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7, Got CP::PingTaskResponse
2025-12-12T12:26:55.955832Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Ping response success: { expired_at { seconds: 1765542435 nanos: 950000000 } }
2025-12-12T12:26:55.955842Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Forward request Private::PingTask
2025-12-12T12:26:55.956285Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7, Request CP::PingTask with size: 192 bytes
2025-12-12T12:26:55.956360Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f7"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
status: RUNNING
resources {
  rate_limiter: READY
  compilation: PREPARE
  rate_limiter_path: "local/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628815
  nanos: 925330000
}
tenant: "/default"
}
2025-12-12T12:26:55.972998Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542435 nanos: 960000000 } } SUCCESS
2025-12-12T12:26:55.973032Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7, Got CP::PingTaskResponse
2025-12-12T12:26:55.973409Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Ping response success: { expired_at { seconds: 1765542435 nanos: 960000000 } }
2025-12-12T12:26:55.973418Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Forward request Private::PingTask
2025-12-12T12:26:55.973895Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7, Request CP::PingTask with size: 114 bytes
2025-12-12T12:26:55.973946Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f7"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628815
  nanos: 925330000
}
tenant: "/default"
}
2025-12-12T12:26:55.988758Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: NodesHealthCheckRequest - NodesHealthCheckResult: {nodes { node_id: 1 instance_id: "cd1ef00f-46633fc8-ba674b4-747e39e0" hostname: "ghrun-fhkyrtz6p4" node_address: "127.0.1.1" } } SUCCESS
2025-12-12T12:26:55.989214Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:389: Send NodeInfo with size: 0 to DynamicNameserver
2025-12-12T12:26:56.060117Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542436 nanos: 15000000 } } SUCCESS
2025-12-12T12:26:56.060212Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7, Got CP::PingTaskResponse
2025-12-12T12:26:56.063263Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Ping response success: { expired_at { seconds: 1765542436 nanos: 15000000 } }
2025-12-12T12:26:56.063289Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Forward request Private::PingTask
2025-12-12T12:26:56.063693Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7, Request CP::PingTask with size: 584 bytes
2025-12-12T12:26:56.063853Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f7"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
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_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628815
  nanos: 925330000
}
tenant: "/default"
}
2025-12-12T12:26:56.076743Z :YQ_CONTROL_PLANE_STORAGE DEBUG: task_ping.cpp:427: PingTaskRequest (resign):  FAILURE ABORTED 0 2025-12-12T12:26:54.966482Z 0.000000s
2025-12-12T12:26:56.167414Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542416 nanos: 76000000 } } SUCCESS
2025-12-12T12:26:56.167515Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7, Got CP::PingTaskResponse
2025-12-12T12:26:56.171156Z :FQ_PINGER ERROR: pinger.cpp:365: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Ping response error: Query ownership time is over: expired_at=2025-12-12T12:26:56.076000Z < now=2025-12-12T12:26:56.171126Z. Retried 0 times during 0.108547s
2025-12-12T12:26:56.171184Z :FQ_PINGER DEBUG: pinger.cpp:379: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Query finished
2025-12-12T12:26:56.171187Z :FQ_PINGER TRACE: pinger.cpp:187: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f7 Stop Pinger
2025-12-12T12:26:56.203978Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:56.204025Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582946937664572587:2328]
2025-12-12T12:26:56.204048Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:26:56.204078Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582946937664572588:2329]
2025-12-12T12:26:56.204115Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:56.204133Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:26:56.204147Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:56.204162Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:26:56.209101Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:26:56.209155Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=1/100 REFRESHED
2025-12-12T12:26:56.209191Z :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=1/100} SEND QUOTAS
2025-12-12T12:26:56.209206Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:26:56.209256Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:56.209309Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582946937664572593:2334]
2025-12-12T12:26:56.209336Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:26:56.209350Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:56.209360Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582946937664572594:2335]
2025-12-12T12:26:56.209400Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudq7ufppheikkkd58"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:26:56.211037Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:26:56.212501Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudq7ufppheikkkd58" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1765542413 nanos: 416891000 } modified_at { seconds: 1765542414 nanos: 966327000 } revision: 2 } started_at { seconds: 1765542415 nanos: 931000000 } execute_mode: RUN status: FAILING last_job_query_revision: 2 last_job_id: "ptjudq7ufoa8d285dv2o-ptqudq7ufppheikkkd58" started_by: "root@builtin" submitted_at { seconds: 1765542414 nanos: 966327000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } text: "blablabla" } issue { message: "Query failed with code ABORTED at 2025-12-12T12:26:56.076709Z" 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-12-12T12:26:56.216223Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=1/100 NOTIFY CHANGE
2025-12-12T12:26:56.218267Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:26:56.720016Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:56.720079Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582946937664572598:2338]
2025-12-12T12:26:56.720104Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:26:56.720132Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582946937664572599:2339]
2025-12-12T12:26:56.720171Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:56.720188Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:26:56.720198Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:56.720232Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:26:56.724397Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:26:56.724429Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=1/100 REFRESHED
2025-12-12T12:26:56.724456Z :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=1/100} SEND QUOTAS
2025-12-12T12:26:56.724470Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:26:56.724505Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:56.724558Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582946937664572604:2344]
2025-12-12T12:26:56.724601Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:26:56.724641Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:56.724679Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582946937664572605:2345]
2025-12-12T12:26:56.724738Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudq7ufppheikkkd58"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:26:56.726737Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudq7ufppheikkkd58" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1765542413 nanos: 416891000 } modified_at { seconds: 1765542414 nanos: 966327000 } revision: 2 } started_at { seconds: 1765542415 nanos: 931000000 } execute_mode: RUN status: FAILING last_job_query_revision: 2 last_job_id: "ptjudq7ufoa8d285dv2o-ptqudq7ufppheikkkd58" started_by: "root@builtin" submitted_at { seconds: 1765542414 nanos: 966327000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } text: "blablabla" } issue { message: "Query failed with code ABORTED at 2025-12-12T12:26:56.076709Z" 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-12-12T12:26:56.727081Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:26:56.729940Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:26:56.729950Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=1/100 NOTIFY CHANGE
2025-12-12T12:26:56.914573Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7582946911894768535:2081]
2025-12-12T12:26:56.914598Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-12T12:26:56.914607Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:356: Coordinator: TEvPing received, [1:7582946911894768519:2069]
2025-12-12T12:26:56.914612Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [1:7582946911894768519:2069]
2025-12-12T12:26:56.914615Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:359: Coordinator: Send TEvPong to [1:7582946911894768519:2069]
2025-12-12T12:26:56.914630Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-12T12:26:56.917745Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f9, Host: ghrun-fhkyrtz6p4, Tenant: /default
2025-12-12T12:26:56.919387Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f9, Host: ghrun-fhkyrtz6p4, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-12-12T12:26:56.919452Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f9"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:26:56.923162Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:456: Task (Query): ptqudq7ufppheikkkd58 Lease TIMEOUT, RetryCounterUpdatedAt 2025-12-12T12:26:54.966482Z LastSeenAt: 2025-12-12T12:26:56.076833Z
2025-12-12T12:26:56.923182Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:463: Task (Query): ptqudq7ufppheikkkd58 RetryRate: 1.999742974 RetryCounter: 1 At: 2025-12-12T12:26:56.923121Z
2025-12-12T12:26:56.931432Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-12-12T12:26:56.931889Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {tasks { query_id { value: "ptqudq7ufppheikkkd58" } job_id { value: "ptjudq7ufoa8d285dv2o" } generation: 3 streaming: true dq_graph: "\022\305\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(88a034dc314301cb1522a933e690a4c49a7591e8\032\023dq_vanilla_job.lite \002H\001RClocal/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiterZ)mock_cloud/my_folder/ptqudq7ufppheikkkd58`\200\200\200\200 \"\017\037\000\205\002\203\002\034column0/*\007column02qptqudq7ufppheikkkd58#ptrudq7ufp5s91uul840#yandexcloud://my_folder#78872d7c-df927b5a-4e4cc88f-87204a6f4#mock_cloud:\024\n\017_LiteralTimeout\022\0010:\022\n\r_TableTimeout\022\0010:\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: STREAMING 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: 1765628816 nanos: 926511000 } disposition { fresh { } } result_limit: 20971520 execution_limit { } request_started_at { seconds: 1765542415 nanos: 931000000 } restart_count: 1 resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter" } compute_connection { } result_ttl { seconds: 86400 } request_submitted_at { seconds: 1765542414 nanos: 966327000 } } } SUCCESS
2025-12-12T12:26:56.931996Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f9, Host: ghrun-fhkyrtz6p4, Tenant: /default, Got CP::GetTask Response
2025-12-12T12:26:56.932361Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-12T12:26:56.932372Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 1
2025-12-12T12:26:56.932384Z :FQ_PENDING_FETCHER DEBUG: pending_fetcher.cpp:361: NewTask: Scope: yandexcloud://my_folder Id: ptqudq7ufppheikkkd58 UserId: root@builtin AuthToken: **** (B6C6F477)
2025-12-12T12:26:56.932513Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f10, Host: ghrun-fhkyrtz6p4, Tenant: /default
2025-12-12T12:26:56.932534Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:375: QueryId: ptqudq7ufppheikkkd58 Start run actor. Compute state: FAILING
2025-12-12T12:26:56.932536Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:469: QueryId: ptqudq7ufppheikkkd58 FillConnections
2025-12-12T12:26:56.932565Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:2333: QueryId: ptqudq7ufppheikkkd58 Run actors params: { QueryId: ptqudq7ufppheikkkd58 CloudId: mock_cloud UserId: root@builtin Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f9 PreviousQueryRevision: 3 Connections: 0 Bindings: 0 AccountIdSignatures: 0 QueryType: STREAMING ExecuteMode: RUN ResultId: ptrudq7ufme8dqpu1ka6 StateLoadMode: EMPTY StreamingDisposition: { fresh { } } Status: FAILING DqGraphs: 1 DqGraphIndex: 0 Resource.TopicConsumers: 0 }
2025-12-12T12:26:56.932575Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1827: QueryId: ptqudq7ufppheikkkd58 Is about to finish query with status FAILED
2025-12-12T12:26:56.932581Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1507: QueryId: ptqudq7ufppheikkkd58 Start rate limiter resource deleter
2025-12-12T12:26:56.932593Z :FQ_PINGER TRACE: pinger.cpp:171: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f9 Start Pinger
2025-12-12T12:26:56.937832Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f10, Host: ghrun-fhkyrtz6p4, Tenant: /default, Request CP::GetTask with size: 69 bytes
2025-12-12T12:26:56.937887Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f10"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:26:56.937889Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:175: PrivateDeleteRateLimiterResource - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f9, Request CP::DeleteRateLimiterResource with size: 97 bytes
2025-12-12T12:26:56.937980Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: DeleteRateLimiterResourceRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f9"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
scope: "yandexcloud://my_folder"
tenant: "/default"
} 
2025-12-12T12:26:56.940838Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:26:56.940897Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f10, Host: ghrun-fhkyrtz6p4, Tenant: /default, Got CP::GetTask Response
2025-12-12T12:26:56.941287Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-12T12:26:56.941292Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-12T12:26:56.941506Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: DeleteRateLimiterResourceRequest. Got response from database: SUCCESS
2025-12-12T12:26:56.941617Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run delete rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58" actor
2025-12-12T12:26:56.941620Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call delete rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58"
2025-12-12T12:26:56.945831Z :YQ_RATE_LIMITER DEBUG: schema.cpp:179: Successfully deleted rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58"
2025-12-12T12:26:56.945838Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for delete rate limiter resource "mock_cloud/my_folder/ptqudq7ufppheikkkd58": 
2025-12-12T12:26:56.945876Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:219: Got delete response from rate limiter service
2025-12-12T12:26:56.945896Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:199: PrivateDeleteRateLimiterResource - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f9, Got CP::DeleteRateLimiterResourceResponse
2025-12-12T12:26:56.946274Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1498: QueryId: ptqudq7ufppheikkkd58 Rate limiter resource deletion finished. Success: 1. Issues: 
2025-12-12T12:26:56.946280Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1919: QueryId: ptqudq7ufppheikkkd58 SendPingAndPassAway, FinalQueryStatus FAILED
2025-12-12T12:26:56.946290Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:536: QueryId: ptqudq7ufppheikkkd58 PassAway
2025-12-12T12:26:56.946418Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f9 Forward ping request: { result_id { } status: FAILED resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter" } finished_at { seconds: 1765542416 nanos: 932000000 } }
2025-12-12T12:26:56.946421Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f9 Forward request Private::PingTask
2025-12-12T12:26:56.946954Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f9, Request CP::PingTask with size: 209 bytes
2025-12-12T12:26:56.947043Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "78872d7c-df927b5a-4e4cc88f-87204a6f9"
query_id {
  value: "ptqudq7ufppheikkkd58"
}
result_id {
}
status: FAILED
resources {
  rate_limiter: READY
  compilation: PREPARE
  rate_limiter_path: "local/RateLimiter_9865b209-1f3d-429e-89d8-16533d8bf471/rate_limiter"
}
scope: "yandexcloud://my_folder"
finished_at {
  seconds: 1765542416
  nanos: 932000000
}
deadline {
  seconds: 1765628816
  nanos: 926511000
}
tenant: "/default"
}
2025-12-12T12:26:56.953111Z :YQ_CONTROL_PLANE_STORAGE NOTICE: task_ping.cpp:224: Query ptqudq7ufppheikkkd58 is NOT billable, status: FAILED, statusCode: ABORTED
2025-12-12T12:26:57.032614Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {} SUCCESS
2025-12-12T12:26:57.032698Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f9, Got CP::PingTaskResponse
2025-12-12T12:26:57.033382Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f9 Ping response success: {  }
2025-12-12T12:26:57.033393Z :FQ_PINGER DEBUG: pinger.cpp:379: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f9 Query finished
2025-12-12T12:26:57.033395Z :FQ_PINGER TRACE: pinger.cpp:187: QueryId: ptqudq7ufppheikkkd58, Owner: 78872d7c-df927b5a-4e4cc88f-87204a6f9 Stop Pinger
2025-12-12T12:26:57.229350Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:57.229403Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582946941959539924:2367]
2025-12-12T12:26:57.229423Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:26:57.229445Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582946941959539925:2368]
2025-12-12T12:26:57.229488Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:57.229503Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:26:57.229507Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:57.229547Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:26:57.233693Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:26:57.233719Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=0/100 REFRESHED
2025-12-12T12:26:57.233740Z :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-12-12T12:26:57.233758Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:26:57.233807Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:57.233857Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582946941959539930:2373]
2025-12-12T12:26:57.233873Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:26:57.233887Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:57.233898Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582946941959539931:2374]
2025-12-12T12:26:57.233925Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudq7ufppheikkkd58"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:26:57.237134Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudq7ufppheikkkd58" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1765542413 nanos: 416891000 } modified_at { seconds: 1765542414 nanos: 966327000 } revision: 2 } started_at { seconds: 1765542415 nanos: 931000000 } finished_at { seconds: 1765542416 nanos: 932000000 } execute_mode: RUN status: FAILED last_job_query_revision: 2 last_job_id: "ptjudq7ufoa8d285dv2o-ptqudq7ufppheikkkd58" started_by: "root@builtin" submitted_at { seconds: 1765542414 nanos: 966327000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } text: "blablabla" } issue { message: "Query failed with code ABORTED at 2025-12-12T12:26:56.076709Z" 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-12-12T12:26:57.239552Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:57.239602Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582946941959539935:2377]
2025-12-12T12:26:57.239615Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:26:57.239627Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582946941959539936:2378]
2025-12-12T12:26:57.239643Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:57.239650Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:26:57.239655Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:26:57.239705Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:26:57.240279Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:26:57.240289Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:636: cloud.mock_cloud.yq.cpuPercent.count=0/10000 RESYNC
2025-12-12T12:26:57.242728Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:26:57.242740Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=0/100 REFRESHED
2025-12-12T12:26:57.242758Z :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-12-12T12:26:57.242772Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:26:57.242795Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:57.242838Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582946941959539939:2381]
2025-12-12T12:26:57.242854Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:26:57.242867Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7ufppheikkkd58"
2025-12-12T12:26:57.242876Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582946941959539940:2382]
2025-12-12T12:26:57.242903Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudq7ufppheikkkd58"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:26:57.244686Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:26:57.244695Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:636: cloud.mock_cloud.yq.streamingQuery.count=0/100 RESYNC
2025-12-12T12:26:57.244705Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:26:57.244708Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:636: cloud.mock_cloud.yq.analyticsQuery.count=0/100 RESYNC
2025-12-12T12:26:57.247065Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudq7ufppheikkkd58" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1765542413 nanos: 416891000 } modified_at { seconds: 1765542414 nanos: 966327000 } revision: 2 } started_at { seconds: 1765542415 nanos: 931000000 } finished_at { seconds: 1765542416 nanos: 932000000 } execute_mode: RUN status: FAILED last_job_query_revision: 2 last_job_id: "ptjudq7ufoa8d285dv2o-ptqudq7ufppheikkkd58" started_by: "root@builtin" submitted_at { seconds: 1765542414 nanos: 966327000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } text: "blablabla" } issue { message: "Query failed with code ABORTED at 2025-12-12T12:26:56.076709Z" 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-12-12T12:26:57.258138Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:26:57.264079Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:26:57.264478Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=0/100 NOTIFY CHANGE
