2025-12-12T12:27:28.690350Z :GRPC_SERVER NOTICE: grpc_request_proxy_simple.cpp:161: Grpc simple request proxy started, nodeid# 1
2025-12-12T12:27:28.690398Z :GRPC_SERVER NOTICE: grpc_request_proxy_simple.cpp:161: Grpc simple request proxy started, nodeid# 1
2025-12-12T12:27:28.690574Z :YQ_TEST_CONNECTION DEBUG: test_connection.cpp:142: Starting yandex query test connection. Actor id: [1:7582947075894211544:2071]
2025-12-12T12:27:28.690600Z :YQ_CONTROL_PLANE_STORAGE INFO: ydb_control_plane_storage.cpp:50: Starting ydb control plane storage service. Actor id: [1:7582947075894211535:2062]
2025-12-12T12:27:28.691053Z :YQ_CONTROL_PLANE_PROXY DEBUG: control_plane_proxy.cpp:525: Starting yandex query control plane proxy. Actor id: [1:7582947075894211537:2064]
2025-12-12T12:27:28.691136Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/connections" actor
2025-12-12T12:27:28.691150Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:214: Bootstrap
2025-12-12T12:27:28.691152Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:217: Create sdk ydb connection
2025-12-12T12:27:28.691177Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:239: Successfully bootstrapped TStorageProxy [1:7582947075894211540:2067] with connection to localhost:9655:local
2025-12-12T12:27:28.691180Z :FQ_QUOTA_PROXY INFO: quota_proxy.cpp:90: STARTED
2025-12-12T12:27:28.691192Z :FQ_LOG_UPDATER DEBUG: log.cpp:93: Updated YQL logs priority: 8
2025-12-12T12:27:28.691192Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/bindings" actor
2025-12-12T12:27:28.691197Z :FQ_LOG_UPDATER CRIT: log.cpp:55: Failed to deliver subscription request to config dispatcher.
2025-12-12T12:27:28.691206Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/quotas" actor
2025-12-12T12:27:28.691208Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/idempotency_keys" actor
2025-12-12T12:27:28.691217Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/tenants" actor
2025-12-12T12:27:28.691218Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/result_sets" actor
2025-12-12T12:27:28.691233Z :FQ_CONTROL_PLANE_CONFIG DEBUG: control_plane_config.cpp:58: STARTING: [1:7582947075894211536:2063]
2025-12-12T12:27:28.691236Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/nodes" actor
2025-12-12T12:27:28.691245Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/tenant_acks" actor
2025-12-12T12:27:28.691251Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/mappings" actor
2025-12-12T12:27:28.691258Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/compute_databases" actor
2025-12-12T12:27:28.691267Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:544: RowDispatcher: Successfully bootstrapped row dispatcher, id [1:7582947075894211541:2068], tenant /cp
2025-12-12T12:27:28.691277Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [1:7582947075894211541:2068]
2025-12-12T12:27:28.691280Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:329: Coordinator: Add new row dispatcher to map (state 1)
2025-12-12T12:27:28.691286Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create directory "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724" actor
2025-12-12T12:27:28.691288Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create directory "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724"
2025-12-12T12:27:28.691301Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:383: Call create directory "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724"
2025-12-12T12:27:28.691319Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create coordination node "local/RateLimiter_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/rate_limiter" actor
2025-12-12T12:27:28.691320Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create coordination node "local/RateLimiter_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/rate_limiter"
2025-12-12T12:27:28.691322Z :YQ_RATE_LIMITER DEBUG: schema.cpp:411: Call create coordination node "local/RateLimiter_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/rate_limiter"
2025-12-12T12:27:28.691345Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/queries" actor
2025-12-12T12:27:28.691357Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:293: Coordinator: Successfully bootstrapped coordinator, id [1:7582947075894211597:2107], NodesManagerId [0:4705493345362661702:78], rebalancing timeout 5.000000s
2025-12-12T12:27:28.691361Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/pending_small" actor
2025-12-12T12:27:28.691368Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:232: TLeaderElection [1:7582947075894211598:2108] Successfully bootstrapped, local coordinator id [1:7582947075894211597:2107], tenant id cp, local mode 0, coordination node path local/cp, endpoint localhost:9655
2025-12-12T12:27:28.691379Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:637: RowDispatcher: TEvCoordinatorChangesSubscribe from [1:7582947075894211597:2107]
2025-12-12T12:27:28.691452Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/jobs" actor
2025-12-12T12:27:28.692488Z :MEMORY_PROFILER NOTICE: monitor.cpp:332: Bootstrapped
2025-12-12T12:27:28.705445Z :FQ_QUOTA_SERVICE INFO: quota_manager.cpp:196: STARTED
2025-12-12T12:27:28.705648Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:71: Run create coordination node "local/cp" actor
2025-12-12T12:27:28.705656Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:113: Call create coordination node "local/cp"
2025-12-12T12:27:28.705657Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:411: Call create coordination node "local/cp"
2025-12-12T12:27:28.719321Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:155: Successfully created coordination node "local/cp"
2025-12-12T12:27:28.719343Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:122: Reply for create coordination node "local/cp": { <main>: Error: Check failed: path: '/local/cp', 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:27:28.719362Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:345: TLeaderElection [1:7582947075894211598:2108] Coordination node successfully created
2025-12-12T12:27:28.719366Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:323: TLeaderElection [1:7582947075894211598:2108] Start session
2025-12-12T12:27:28.721675Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:359: TLeaderElection [1:7582947075894211598:2108] Session successfully created
2025-12-12T12:27:28.723626Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:372: TLeaderElection [1:7582947075894211598:2108] Semaphore successfully created
2025-12-12T12:27:28.723638Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:304: TLeaderElection [1:7582947075894211598:2108] Try to acquire semaphore
2025-12-12T12:27:28.723737Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:420: TLeaderElection [1:7582947075894211598:2108] Describe semaphore
2025-12-12T12:27:28.725343Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:386: TLeaderElection [1:7582947075894211598:2108] Semaphore successfully acquired
2025-12-12T12:27:28.725362Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:469: TLeaderElection [1:7582947075894211598:2108] Semaphore successfully described: coordinator id [1:7582947075894211597:2107] generation 2
2025-12-12T12:27:28.725367Z :FQ_ROW_DISPATCHER INFO: leader_election.cpp:471: TLeaderElection [1:7582947075894211598:2108] Send TEvCoordinatorChanged to [1:7582947075894211541:2068], new coordinator id [1:7582947075894211597:2107], previous coordinator id [0:0:0]
2025-12-12T12:27:28.725867Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/bindings". Create session OK
2025-12-12T12:27:28.725877Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/connections". Create session OK
2025-12-12T12:27:28.725884Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/bindings"
2025-12-12T12:27:28.725885Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/connections"
2025-12-12T12:27:28.725886Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/bindings"
2025-12-12T12:27:28.725888Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/connections"
2025-12-12T12:27:28.726070Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/nodes". Create session OK
2025-12-12T12:27:28.726078Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/nodes"
2025-12-12T12:27:28.726079Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/nodes"
2025-12-12T12:27:28.726122Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/result_sets". Create session OK
2025-12-12T12:27:28.726130Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/result_sets"
2025-12-12T12:27:28.726132Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/result_sets"
2025-12-12T12:27:28.726160Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/queries". Create session OK
2025-12-12T12:27:28.726163Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/queries"
2025-12-12T12:27:28.726164Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/queries"
2025-12-12T12:27:28.726838Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created directory "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724"
2025-12-12T12:27:28.726857Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create directory "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 32], type: EPathTypeDir, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_mkdir.cpp:155 }
2025-12-12T12:27:28.726880Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/mappings". Create session OK
2025-12-12T12:27:28.726886Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/mappings"
2025-12-12T12:27:28.726887Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/mappings"
2025-12-12T12:27:28.727033Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:569: RowDispatcher: Coordinator changed, old leader (empty maybe), new [1:7582947075894211597:2107] generation 2
2025-12-12T12:27:28.727068Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:356: Coordinator: TEvPing received, [1:7582947075894211541:2068]
2025-12-12T12:27:28.727072Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [1:7582947075894211541:2068]
2025-12-12T12:27:28.727074Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:359: Coordinator: Send TEvPong to [1:7582947075894211541:2068]
2025-12-12T12:27:28.727086Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:440: Coordinator: New leader [1:7582947075894211597:2107], SelfId [1:7582947075894211597:2107]
2025-12-12T12:27:28.727090Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-12T12:27:28.727092Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/tenants". Create session OK
2025-12-12T12:27:28.727094Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/tenants"
2025-12-12T12:27:28.727095Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/tenants"
2025-12-12T12:27:28.728724Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/idempotency_keys". Create session OK
2025-12-12T12:27:28.728735Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/idempotency_keys"
2025-12-12T12:27:28.728738Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/idempotency_keys"
2025-12-12T12:27:28.728764Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/jobs". Create session OK
2025-12-12T12:27:28.728767Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/jobs"
2025-12-12T12:27:28.728770Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/jobs"
2025-12-12T12:27:28.730865Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/tenant_acks". Create session OK
2025-12-12T12:27:28.730877Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/tenant_acks"
2025-12-12T12:27:28.730881Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/tenant_acks"
2025-12-12T12:27:28.731024Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/quotas". Create session OK
2025-12-12T12:27:28.731029Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/quotas"
2025-12-12T12:27:28.731031Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/quotas"
2025-12-12T12:27:28.731044Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/pending_small". Create session OK
2025-12-12T12:27:28.731046Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/pending_small"
2025-12-12T12:27:28.731048Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/pending_small"
2025-12-12T12:27:28.731087Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/compute_databases". Create session OK
2025-12-12T12:27:28.731093Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/compute_databases"
2025-12-12T12:27:28.731095Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/compute_databases"
2025-12-12T12:27:28.743339Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/tenants"
2025-12-12T12:27:28.743366Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/tenants": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/tenants', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 33], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504 }
2025-12-12T12:27:28.743716Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/mappings"
2025-12-12T12:27:28.743729Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/mappings": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/mappings', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 34], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504 }
2025-12-12T12:27:28.760851Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created coordination node "local/RateLimiter_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/rate_limiter"
2025-12-12T12:27:28.760865Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create coordination node "local/RateLimiter_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/rate_limiter": 
2025-12-12T12:27:28.766923Z :FQ_CONTROL_PLANE_CONFIG DEBUG: control_plane_config.cpp:190: LOADED TenantInfo: State CHANGED at 2025-12-12T12:27:28.275761Z
2025-12-12T12:27:28.777712Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/compute_databases"
2025-12-12T12:27:28.777732Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/compute_databases": 
2025-12-12T12:27:28.777752Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/idempotency_keys"
2025-12-12T12:27:28.777756Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/idempotency_keys": 
2025-12-12T12:27:28.778073Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/bindings"
2025-12-12T12:27:28.778083Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/bindings": 
2025-12-12T12:27:28.778483Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/connections"
2025-12-12T12:27:28.778492Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/connections": 
2025-12-12T12:27:28.784907Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/queries"
2025-12-12T12:27:28.784920Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/queries": 
2025-12-12T12:27:28.784964Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/jobs"
2025-12-12T12:27:28.784968Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/jobs": 
2025-12-12T12:27:28.785105Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/pending_small"
2025-12-12T12:27:28.785114Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/pending_small": 
2025-12-12T12:27:28.785114Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/tenant_acks"
2025-12-12T12:27:28.785117Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/tenant_acks": 
2025-12-12T12:27:28.785164Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/nodes"
2025-12-12T12:27:28.785172Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/nodes": 
2025-12-12T12:27:28.785180Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/result_sets"
2025-12-12T12:27:28.785183Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/result_sets": 
2025-12-12T12:27:28.785697Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/quotas"
2025-12-12T12:27:28.785705Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/quotas": 
2025-12-12T12:27:29.642652Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741581, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:29.643234Z :YQ_CONTROL_PLANE_STORAGE TRACE: nodes_health_check.cpp:38: NodesHealthCheckRequest: {tenant: "/compute"
node {
  node_id: 1
  instance_id: "45fb0e81-463ed951-c23c0a9b-b885eab8"
  hostname: "ghrun-fhkyrtz6p4"
  interconnect_port: 30132
  node_address: "127.0.1.1"
}
}
2025-12-12T12:27:29.643311Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7b4b3e-d9d2d511-76304cae-9b3741581"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:27:29.713964Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:29.714009Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741581, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:29.717342Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: NodesHealthCheckRequest - NodesHealthCheckResult: {nodes { node_id: 1 instance_id: "45fb0e81-463ed951-c23c0a9b-b885eab8" hostname: "ghrun-fhkyrtz6p4" node_address: "127.0.1.1" } } SUCCESS
2025-12-12T12:27:30.111457Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc211, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:30.111515Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "64531345-a35ad81c-efe217e2-2072bc211"
host: "ghrun-fhkyrtz6p4"
node_id: 2
}
2025-12-12T12:27:30.111576Z :YQ_CONTROL_PLANE_STORAGE TRACE: nodes_health_check.cpp:38: NodesHealthCheckRequest: {tenant: "/compute"
node {
  node_id: 2
  instance_id: "f68ac831-41b1777a-1d35c8ae-69f4b034"
  hostname: "ghrun-fhkyrtz6p4"
  interconnect_port: 15413
  node_address: "127.0.1.1"
}
}
2025-12-12T12:27:30.119439Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:30.119487Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc211, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:30.123233Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: NodesHealthCheckRequest - NodesHealthCheckResult: {nodes { node_id: 2 instance_id: "f68ac831-41b1777a-1d35c8ae-69f4b034" hostname: "ghrun-fhkyrtz6p4" node_address: "127.0.1.1" } nodes { node_id: 1 instance_id: "45fb0e81-463ed951-c23c0a9b-b885eab8" hostname: "ghrun-fhkyrtz6p4" interconnect_port: 30132 node_address: "127.0.1.1" } } SUCCESS
2025-12-12T12:27:30.359749Z :TICKET_PARSER DEBUG: ticket_parser_impl.h:1875: Ticket **** (B6C6F477) (ipv6:[::1]:52218) has now valid token of root@builtin
2025-12-12T12:27:30.359982Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:1330: CreateConnectionRequest: content { name: "yds" setting { data_streams { auth { none { } } endpoint: "localhost:9655" database: "local" shared_reading: true } } acl { visibility: PRIVATE } } 
2025-12-12T12:27:30.360045Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582947084484146246:2160]
2025-12-12T12:27:30.360075Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:27:30.360100Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582947084484146247:2161]
2025-12-12T12:27:30.360126Z :FQ_QUOTA_SERVICE DEBUG: quota_manager.cpp:255: cloud.mock_cloud NOT CASHED, Loading ...
2025-12-12T12:27:30.392152Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:441: cloud.mock_cloud {} FROM DB
2025-12-12T12:27:30.392188Z :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:27:30.392192Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:30.392204Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:27:30.392213Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:30.392240Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:27:30.437103Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:27:30.449288Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:27:30.449313Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=0/100 REFRESHED
2025-12-12T12:27:30.449330Z :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:27:30.449338Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:27:30.449462Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:1330: CreateConnectionRequest: content { name: "yds" setting { data_streams { auth { none { } } endpoint: "localhost:9655" database: "local" shared_reading: true } } acl { visibility: PRIVATE } } 
2025-12-12T12:27:30.449528Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582947084484146253:2167]
2025-12-12T12:27:30.449559Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:27:30.449648Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:1330: CreateConnectionRequest: content { name: "yds" setting { data_streams { auth { none { } } endpoint: "localhost:9655" database: "local" shared_reading: true } } acl { visibility: PRIVATE } } 
2025-12-12T12:27:30.449675Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:435: Create database bootstrap. CloudId: mock_cloud Scope: yandexcloud://my_folder Actor id: [1:7582947084484146254:2168]
2025-12-12T12:27:30.449780Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:1330: CreateConnectionRequest: content { name: "yds" setting { data_streams { auth { none { } } endpoint: "localhost:9655" database: "local" shared_reading: true } } acl { visibility: PRIVATE } } 
2025-12-12T12:27:30.449816Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582947084484146255:2169]
2025-12-12T12:27:30.449973Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_connections.cpp:120: [yandexcloud://my_folder, root@builtin, ptcudq7uemfchldv1md0] CreateConnectionRequest: **** (B6C6F477) content { name: "yds" setting { data_streams { auth { none { } } endpoint: "localhost:9655" database: "local" shared_reading: true } } acl { visibility: PRIVATE } } 
2025-12-12T12:27:30.455705Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:27:30.455759Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:27:30.614509Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d81, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:30.614551Z :YQ_CONTROL_PLANE_STORAGE TRACE: nodes_health_check.cpp:38: NodesHealthCheckRequest: {tenant: "/compute"
node {
  node_id: 3
  instance_id: "3997921e-406fc1c4-683e9b92-54992e12"
  hostname: "ghrun-fhkyrtz6p4"
  interconnect_port: 63718
  node_address: "127.0.1.1"
}
}
2025-12-12T12:27:30.614627Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7123ef-2eb12fc4-4f11a19c-d3f4b1d81"
host: "ghrun-fhkyrtz6p4"
node_id: 3
}
2025-12-12T12:27:30.617086Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:30.617138Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d81, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:30.621394Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: NodesHealthCheckRequest - NodesHealthCheckResult: {nodes { node_id: 3 instance_id: "3997921e-406fc1c4-683e9b92-54992e12" hostname: "ghrun-fhkyrtz6p4" node_address: "127.0.1.1" } nodes { node_id: 1 instance_id: "45fb0e81-463ed951-c23c0a9b-b885eab8" hostname: "ghrun-fhkyrtz6p4" interconnect_port: 30132 node_address: "127.0.1.1" } nodes { node_id: 2 instance_id: "f68ac831-41b1777a-1d35c8ae-69f4b034" hostname: "ghrun-fhkyrtz6p4" interconnect_port: 15413 node_address: "127.0.1.1" } } SUCCESS
2025-12-12T12:27:30.623667Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741582, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:30.623715Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7b4b3e-d9d2d511-76304cae-9b3741582"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:27:30.626021Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:30.626056Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741582, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:30.688983Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7582947075894211597:2107]
2025-12-12T12:27:30.689002Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-12T12:27:30.689014Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:356: Coordinator: TEvPing received, [1:7582947075894211541:2068]
2025-12-12T12:27:30.689019Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [1:7582947075894211541:2068]
2025-12-12T12:27:30.689022Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:359: Coordinator: Send TEvPong to [1:7582947075894211541:2068]
2025-12-12T12:27:30.689047Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-12T12:27:30.794661Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: [yandexcloud://my_folder, root@builtin, ptcudq7uemfchldv1md0] CreateConnectionRequest: {connection_id: "ptcudq7uemfchldv1md0" } SUCCESS
2025-12-12T12:27:30.858603Z :TICKET_PARSER DEBUG: ticket_parser_impl.h:1875: Ticket **** (B6C6F477) (ipv6:[::1]:52218) has now valid token of root@builtin
2025-12-12T12:27:30.858765Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:648: CreateQueryRequest: content {
  type: STREAMING
  name: "simple"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "\n            INSERT INTO yds.`test_filter_missing_fields_output`\n            SELECT Cast(time as String) FROM yds.`test_filter_missing_fields_input`\n                WITH (format=json_each_row, SCHEMA (time UInt64 NOT NULL, `data@data` String, event String NOT NULL))\n                WHERE `data@data` IS NULL;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "517b06a6-c086-4b8f-836b-af922ca6d453"
2025-12-12T12:27:30.858832Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582947084484146268:2181]
2025-12-12T12:27:30.858877Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:27:30.858902Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582947084484146269:2182]
2025-12-12T12:27:30.858924Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:30.858932Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:27:30.858937Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:30.858952Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:27:30.860933Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:27:30.860955Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=0/100 REFRESHED
2025-12-12T12:27:30.860979Z :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:27:30.860989Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:27:30.861066Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:648: CreateQueryRequest: content {
  type: STREAMING
  name: "simple"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "\n            INSERT INTO yds.`test_filter_missing_fields_output`\n            SELECT Cast(time as String) FROM yds.`test_filter_missing_fields_input`\n                WITH (format=json_each_row, SCHEMA (time UInt64 NOT NULL, `data@data` String, event String NOT NULL))\n                WHERE `data@data` IS NULL;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "517b06a6-c086-4b8f-836b-af922ca6d453"
2025-12-12T12:27:30.861141Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582947084484146274:2187]
2025-12-12T12:27:30.861173Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:27:30.861214Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:648: CreateQueryRequest: content {
  type: STREAMING
  name: "simple"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "\n            INSERT INTO yds.`test_filter_missing_fields_output`\n            SELECT Cast(time as String) FROM yds.`test_filter_missing_fields_input`\n                WITH (format=json_each_row, SCHEMA (time UInt64 NOT NULL, `data@data` String, event String NOT NULL))\n                WHERE `data@data` IS NULL;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "517b06a6-c086-4b8f-836b-af922ca6d453"
2025-12-12T12:27:30.861262Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:435: Create database bootstrap. CloudId: mock_cloud Scope: yandexcloud://my_folder Actor id: [1:7582947084484146275:2188]
2025-12-12T12:27:30.861322Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:648: CreateQueryRequest: content {
  type: STREAMING
  name: "simple"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "\n            INSERT INTO yds.`test_filter_missing_fields_output`\n            SELECT Cast(time as String) FROM yds.`test_filter_missing_fields_input`\n                WITH (format=json_each_row, SCHEMA (time UInt64 NOT NULL, `data@data` String, event String NOT NULL))\n                WHERE `data@data` IS NULL;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "517b06a6-c086-4b8f-836b-af922ca6d453"
2025-12-12T12:27:30.861357Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582947084484146276:2189]
2025-12-12T12:27:30.861380Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:248: Create rate limiter resource for cloud with limit 100000ms
2025-12-12T12:27:30.861415Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create rate limiter resource "mock_cloud" actor
2025-12-12T12:27:30.861421Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud"
2025-12-12T12:27:30.863778Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created rate limiter resource "mock_cloud"
2025-12-12T12:27:30.863790Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create rate limiter resource "mock_cloud": 
2025-12-12T12:27:30.863821Z :YQ_CONTROL_PLANE_PROXY DEBUG: request_actor.h:272: Create response from rate limiter service. Success: 1
2025-12-12T12:27:30.863920Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:226: CreateQueryRequest: {content {
  type: STREAMING
  name: "simple"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "\n            INSERT INTO yds.`test_filter_missing_fields_output`\n            SELECT Cast(time as String) FROM yds.`test_filter_missing_fields_input`\n                WITH (format=json_each_row, SCHEMA (time UInt64 NOT NULL, `data@data` String, event String NOT NULL))\n                WHERE `data@data` IS NULL;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "517b06a6-c086-4b8f-836b-af922ca6d453"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:27:30.865773Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:27:30.866140Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:27:30.866217Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:27:31.085788Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: CreateQueryRequest - CreateQueryResult: {query_id: "ptqudq7uem2o5or4krva" } SUCCESS
2025-12-12T12:27:31.088269Z :TICKET_PARSER DEBUG: ticket_parser_impl.h:1875: Ticket **** (B6C6F477) (ipv6:[::1]:52218) has now valid token of root@builtin
2025-12-12T12:27:31.088373Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7uem2o5or4krva"
2025-12-12T12:27:31.088421Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582947088779113577:2193]
2025-12-12T12:27:31.088445Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:27:31.088471Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582947088779113578:2194]
2025-12-12T12:27:31.088501Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:31.088516Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:27:31.088539Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:31.088555Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:27:31.094651Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:27:31.101244Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc212, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:31.101335Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
host: "ghrun-fhkyrtz6p4"
node_id: 2
}
2025-12-12T12:27:31.103677Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:463: Task (Query): ptqudq7uem2o5or4krva RetryRate: 0 RetryCounter: 0 At: 2025-12-12T12:27:30.944866Z
2025-12-12T12:27:31.117132Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:27:31.117164Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=1/100 REFRESHED
2025-12-12T12:27:31.117189Z :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:27:31.117197Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:27:31.117222Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7uem2o5or4krva"
2025-12-12T12:27:31.117284Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582947088779113587:2203]
2025-12-12T12:27:31.117325Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:27:31.117378Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7uem2o5or4krva"
2025-12-12T12:27:31.117421Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582947088779113588:2204]
2025-12-12T12:27:31.117511Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudq7uem2o5or4krva"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:27:31.123350Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:27:31.123443Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=1/100 NOTIFY CHANGE
2025-12-12T12:27:31.156489Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudq7uem2o5or4krva" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1765542450 nanos: 863842000 } modified_at { seconds: 1765542450 nanos: 863842000 } revision: 1 } execute_mode: RUN status: STARTING last_job_query_revision: 1 last_job_id: "ptjudq7uem2o4v3tpmvh-ptqudq7uem2o5or4krva" started_by: "root@builtin" submitted_at { seconds: 1765542450 nanos: 863842000 } } content { type: STREAMING name: "simple" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "\n            INSERT INTO yds.`test_filter_missing_fields_output`\n            SELECT Cast(time as String) FROM yds.`test_filter_missing_fields_input`\n                WITH (format=json_each_row, SCHEMA (time UInt64 NOT NULL, `data@data` String, event String NOT NULL))\n                WHERE `data@data` IS NULL;" syntax: YQL_V1 } } } SUCCESS
2025-12-12T12:27:31.207864Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {tasks { query_id { value: "ptqudq7uem2o5or4krva" } job_id { value: "ptjudq7uem2o4v3tpmvh" } generation: 1 streaming: true text: "\n            INSERT INTO yds.`test_filter_missing_fields_output`\n            SELECT Cast(time as String) FROM yds.`test_filter_missing_fields_input`\n                WITH (format=json_each_row, SCHEMA (time UInt64 NOT NULL, `data@data` String, event String NOT NULL))\n                WHERE `data@data` IS NULL;" connection { content { name: "yds" setting { data_streams { auth { none { } } endpoint: "localhost:9655" database: "local" shared_reading: true } } acl { visibility: PRIVATE } } meta { id: "ptcudq7uemfchldv1md0" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1765542450 nanos: 449847000 } modified_at { seconds: 1765542450 nanos: 449847000 } revision: 1 } } 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: "simple" deadline { seconds: 1765628851 nanos: 151684000 } 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: 1765542450 nanos: 863842000 } } } SUCCESS
2025-12-12T12:27:31.207925Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc212, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:31.208966Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc213, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:31.209022Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "64531345-a35ad81c-efe217e2-2072bc213"
host: "ghrun-fhkyrtz6p4"
node_id: 2
}
2025-12-12T12:27:31.209144Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:78: PrivateCreateRateLimiterResource - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::CreateRateLimiterResource with size: 97 bytes
2025-12-12T12:27:31.209163Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 127 bytes
2025-12-12T12:27:31.209185Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: CreateRateLimiterResourceRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
scope: "yandexcloud://my_folder"
tenant: "/compute"
} 
2025-12-12T12:27:31.209230Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
scope: "yandexcloud://my_folder"
started_at {
  seconds: 1765542451
  nanos: 208000000
}
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:31.211200Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:31.211222Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc213, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:31.245365Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: CreateRateLimiterResourceRequest. Got response from database: SUCCESS
2025-12-12T12:27:31.245482Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create rate limiter resource "mock_cloud/my_folder/ptqudq7uem2o5or4krva" actor
2025-12-12T12:27:31.245492Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder/ptqudq7uem2o5or4krva"
2025-12-12T12:27:31.246747Z :YQ_RATE_LIMITER DEBUG: schema.cpp:261: Trying to recursively create rate limiter resource "mock_cloud/my_folder"
2025-12-12T12:27:31.246759Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder"
2025-12-12T12:27:31.248718Z :YQ_RATE_LIMITER DEBUG: schema.cpp:244: Successfully created rate limiter resource "mock_cloud/my_folder"
2025-12-12T12:27:31.248732Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder/ptqudq7uem2o5or4krva"
2025-12-12T12:27:31.250962Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created rate limiter resource "mock_cloud/my_folder/ptqudq7uem2o5or4krva"
2025-12-12T12:27:31.250979Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create rate limiter resource "mock_cloud/my_folder/ptqudq7uem2o5or4krva": 
2025-12-12T12:27:31.251027Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:180: Got create response from rate limiter service
2025-12-12T12:27:31.251055Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:102: PrivateCreateRateLimiterResource - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::CreateRateLimiterResourceResponse
2025-12-12T12:27:31.404902Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542471 nanos: 332000000 } } SUCCESS
2025-12-12T12:27:31.404957Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:31.405912Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 122 bytes
2025-12-12T12:27:31.405994Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
status: RUNNING
resources {
  rate_limiter: PREPARE
  compilation: PREPARE
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:31.416464Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542471 nanos: 411000000 } } SUCCESS
2025-12-12T12:27:31.416515Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:31.417438Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 191 bytes
2025-12-12T12:27:31.417528Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
status: RUNNING
resources {
  rate_limiter: READY
  compilation: PREPARE
  rate_limiter_path: "local/RateLimiter_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/rate_limiter"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:31.426949Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542471 nanos: 422000000 } } SUCCESS
2025-12-12T12:27:31.427054Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:31.427925Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 2175 bytes
2025-12-12T12:27:31.428021Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
ast: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (DataSource \'\"pq\" \'\"yds\"))\n(let $3 \'(\'(\'\"PartitionsCount\" \'\"1\")))\n(let $4 (DataType \'String))\n(let $5 (StructType \'(\'\"data@data\" (OptionalType $4)) \'(\'\"time\" (DataType \'Uint64))))\n(let $6 (PqTopic \'\"yds\" \'\"local\" \'\"test_filter_missing_fields_input\" $3 \'() $5))\n(let $7 \'(\'\"Endpoint\" \'\"localhost:9655\"))\n(let $8 \'(\'\"SharedReading\" \'\"1\"))\n(let $9 \'(\'\"AddBearerToToken\" \'\"1\"))\n(let $10 \'($7 $8 \'(\'\"ReconnectPeriod\" \'\"\") \'(\'\"Format\" \'\"json_each_row\") \'(\'\"ReadGroup\" \'\"ptcudq7uemfchldv1md0\") $9))\n(let $11 (SecureParam \'\"cluster:default_yds\"))\n(let $12 (DqPqTopicSource $1 $6 \'(\'\"data@data\" \'\"time\") $10 $11 \'\"2\\r\\n\\v\\x12\\tdata@data\" $5 \'\"\"))\n(let $13 (DataSink \'\"pq\" \'\"yds\"))\n(let $14 (PqTopic \'\"yds\" \'\"local\" \'\"test_filter_missing_fields_output\" $3 \'() (StructType \'(\'\"Data\" $4))))\n(let $15 (DqPqTopicSink $14 \'($7 $9) $11))\n(return (Commit! (DqQuery! $1 \'((DqStage \'((DqSource $2 $12)) (lambda \'($16) (block \'(\n  (let $17 \'(\'(\'\"format\" \'\"json_each_row\") \'(\'\"formatSettings\" \'(\'(\'\"data.datetime.formatname\" \'\"POSIX\") \'(\'\"data.timestamp.formatname\" \'\"POSIX\"))) \'(\'\"settings\" \'($8))))\n  (let $18 (DqSourceWideWrap $16 $2 $5 $17))\n  (return (FlatMap (NarrowMap $18 (lambda \'($19 $20) (AsStruct \'(\'\"data@data\" $19) \'(\'\"time\" $20)))) (lambda \'($21) (OptionalIf (Not (Exists (Member $21 \'\"data@data\"))) (AsStruct \'(\'\"column0\" (SafeCast (Member $21 \'\"time\") $4)))))))\n))) \'(\'(\'\"_logical_id\" \'200597)) \'((DqSink \'\"0\" $13 $15))))) $13))\n)\n"
plan: "{\"Detailed\":{\"Operations\":[{\"Id\":3,\"Name\":\"DqStage\",\"Streams\":{\"Program\":[{\"Name\":\"DqSourceWideWrap\"},{\"Name\":\"NarrowMap\"},{\"Name\":\"FlatMap\"}]}},{\"Id\":2,\"Name\":\"DqQuery!\",\"DependsOn\":[3]},{\"Id\":1,\"Name\":\"Commit!\",\"DependsOn\":[2]}],\"OperationRoot\":1,\"Providers\":[],\"OperationStats\":{\"Commit!\":1,\"DqQuery!\":1,\"DqStage\":1}},\"Basic\":{\"nodes\":[{\"id\":3,\"level\":1,\"name\":\"DqStage #3\",\"type\":\"op\"},{\"id\":2,\"level\":2,\"name\":\"DqQuery!\",\"type\":\"op\"},{\"id\":1,\"level\":3,\"name\":\"Commit!\",\"type\":\"op\"}],\"links\":[{\"source\":3,\"target\":2},{\"source\":2,\"target\":1}]}}"
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:31.436860Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542471 nanos: 432000000 } } SUCCESS
2025-12-12T12:27:31.436903Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:31.439043Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 210 bytes
2025-12-12T12:27:31.439175Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
transient_issues {
  message: "Execution"
  issue_code: 1060
  severity: 1
  issues {
    position {
      row: 3
      column: 13
    }
    message: "Row dispatcher will use the predicate: (`data@data` IS NULL)"
    end_position {
      row: 3
      column: 13
    }
    severity: 1
  }
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:31.449477Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542471 nanos: 443000000 } } SUCCESS
2025-12-12T12:27:31.449516Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:31.452897Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 1894 bytes
2025-12-12T12:27:31.453017Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
dq_graph: "\022\260\007\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\006*\355\003Z\352\003\n\010PqSource\022\333\003\n4type.googleapis.com/NYql.NPq.NProto.TDqPqTopicSource\022\242\003\n test_filter_missing_fields_input\022\024ptqudq7uem2o5or4krva\032\016localhost:9655\"\025\n\023cluster:default_yds*\005local0\002@\001b\tdata@datab\004timej&[\"OptionalType\";[\"DataType\";\"String\"]]j\025[\"DataType\";\"Uint64\"]r\025(`data@data` IS NULL)x\001\222\001\024ptcudq7uemfchldv1md0\232\001\rjson_each_row\242\001d[\"StructType\";[[\"data@data\";[\"OptionalType\";[\"DataType\";\"String\"]]];[\"time\";[\"DataType\";\"Uint64\"]]]]\262\001\002\022\000\272\001\026\n\010cloud_id\022\nmock_cloud\272\001 \n\005scope\022\027yandexcloud://my_folder\030\0012\231\001z\226\001\n\006PqSink\022\213\001\n2type.googleapis.com/NYql.NPq.NProto.TDqPqTopicSink\022U\n!test_filter_missing_fields_output\022\016localhost:9655\032\025\n\023cluster:default_yds\"\005local0\0018\002:\203\001\n*type.googleapis.com/Yql.DqsProto.TTaskMeta\022U\010\235\242\014\022A\022(88a034dc314301cb1522a933e690a4c49a7591e8\032\023dq_vanilla_job.lite \002\"\014\n\002pq\022\006\n\004\010\001\030\001H\235\242\014RClocal/RateLimiter_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/rate_limiterZ)mock_cloud/my_folder/ptqudq7uem2o5or4krva`\200\200\200\200 \230\001\000\300\001\0012qptqudq7uem2o5or4krva#ptrudq7uelo7oeq82qn2#yandexcloud://my_folder#64531345-a35ad81c-efe217e2-2072bc212#mock_cloud:\027\n\016FallbackPolicy\022\005never:\024\n\017_LiteralTimeout\022\0010:\022\n\r_TableTimeout\022\0010:\027\n\022_RowsLimitPerWrite\022\0010:\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\0011B%\n\023cluster:default_yds\022\016{\"no_auth\":\"\"}b\365\002\010\235\242\014\022\356\002\037\004\006Arg\014Member\005\205\006\213\002\204\205\004\207\203\005@\203\010$data@data\020time\205\000\204\205\002\203\005@\034column0\030Inputs(Parameters\034Program\013?\n)\251\000?\010\002\000\026\000)\251\000?\014\002\000\")\211\002?\022\215?\020 FromFlow\000)\211\010? \215\233\004?\002?\004?\002?\004?\020$NarrowMap\000)\211\010?&?&?\002?\004\203\014(WideFilter\000)\211\010?&\215?\006?\006?\002?\004$ExpandMap\000)\211\002?.?\010\030ToFlow\000?\030\000\030)\251\000?\006\002\000\020)\211\004?\002?\006\203\004\006\000?8\003?:\000\002\024)\211\004?\004?\006\203\004\006\000?8\003?B\002\002\022\000\032)\251\000?\002\002\000\010)\251\000?\004\002\000\016)\211\002?*?*\014Not\000)\211\002?*?\002\030Exists\000?N\000\n\000\014\000\034)\251\000?\002\002\000\006)\251\000?\004\002\000\002\005?\020)\211\002?\016?\004 ToString\000?d\000\004\000\010\036\000 \001/"
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:31.467319Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542471 nanos: 459000000 } } SUCCESS
2025-12-12T12:27:31.467360Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:31.468534Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 298 bytes
2025-12-12T12:27:31.468653Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
status: RUNNING
resources {
  rate_limiter: READY
  compilation: READY
  topic_consumers_state: PREPARE
  rate_limiter_path: "local/RateLimiter_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/rate_limiter"
  topic_consumers {
    database: "local"
    topic_path: "test_filter_missing_fields_input"
    consumer_name: "ptqudq7uem2o5or4krva"
    cluster_endpoint: "localhost:9655"
    token_name: "cluster:default_yds"
    add_bearer_to_token: true
  }
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:31.478771Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542471 nanos: 473000000 } } SUCCESS
2025-12-12T12:27:31.478803Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:31.485886Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 298 bytes
2025-12-12T12:27:31.486002Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
status: RUNNING
resources {
  rate_limiter: READY
  compilation: READY
  topic_consumers_state: READY
  rate_limiter_path: "local/RateLimiter_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/rate_limiter"
  topic_consumers {
    database: "local"
    topic_path: "test_filter_missing_fields_input"
    consumer_name: "ptqudq7uem2o5or4krva"
    cluster_endpoint: "localhost:9655"
    token_name: "cluster:default_yds"
    add_bearer_to_token: true
  }
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:31.497064Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542471 nanos: 491000000 } } SUCCESS
2025-12-12T12:27:31.497110Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:31.603341Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d82, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:31.603405Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7123ef-2eb12fc4-4f11a19c-d3f4b1d82"
host: "ghrun-fhkyrtz6p4"
node_id: 3
}
2025-12-12T12:27:31.605624Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:31.605659Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d82, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:31.624700Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741583, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:31.624775Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7b4b3e-d9d2d511-76304cae-9b3741583"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:27:31.626765Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:31.626797Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741583, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:31.659021Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7uem2o5or4krva"
2025-12-12T12:27:31.659068Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582947088779113630:2245]
2025-12-12T12:27:31.659098Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:27:31.659118Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582947088779113631:2246]
2025-12-12T12:27:31.659149Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:31.659165Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:27:31.659182Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:31.659206Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:27:31.662626Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:27:31.662673Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=1/100 REFRESHED
2025-12-12T12:27:31.662703Z :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:27:31.662724Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:27:31.662753Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7uem2o5or4krva"
2025-12-12T12:27:31.662802Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582947088779113636:2251]
2025-12-12T12:27:31.662834Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:27:31.662861Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7uem2o5or4krva"
2025-12-12T12:27:31.662906Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582947088779113637:2252]
2025-12-12T12:27:31.662959Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudq7uem2o5or4krva"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:27:31.664768Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:27:31.664843Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudq7uem2o5or4krva" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1765542450 nanos: 863842000 } modified_at { seconds: 1765542450 nanos: 863842000 } revision: 1 } started_at { seconds: 1765542451 nanos: 208000000 } execute_mode: RUN status: RUNNING last_job_query_revision: 1 last_job_id: "ptjudq7uem2o4v3tpmvh-ptqudq7uem2o5or4krva" started_by: "root@builtin" submitted_at { seconds: 1765542450 nanos: 863842000 } } content { type: STREAMING name: "simple" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "\n            INSERT INTO yds.`test_filter_missing_fields_output`\n            SELECT Cast(time as String) FROM yds.`test_filter_missing_fields_input`\n                WITH (format=json_each_row, SCHEMA (time UInt64 NOT NULL, `data@data` String, event String NOT NULL))\n                WHERE `data@data` IS NULL;" syntax: YQL_V1 } plan { json: "{\"Detailed\":{\"Operations\":[{\"Id\":3,\"Name\":\"DqStage\",\"Streams\":{\"Program\":[{\"Name\":\"DqSourceWideWrap\"},{\"Name\":\"NarrowMap\"},{\"Name\":\"FlatMap\"}]}},{\"Id\":2,\"Name\":\"DqQuery!\",\"DependsOn\":[3]},{\"Id\":1,\"Name\":\"Commit!\",\"DependsOn\":[2]}],\"OperationRoot\":1,\"Providers\":[],\"OperationStats\":{\"Commit!\":1,\"DqQuery!\":1,\"DqStage\":1}},\"Basic\":{\"nodes\":[{\"id\":3,\"level\":1,\"name\":\"DqStage #3\",\"type\":\"op\"},{\"id\":2,\"level\":2,\"name\":\"DqQuery!\",\"type\":\"op\"},{\"id\":1,\"level\":3,\"name\":\"Commit!\",\"type\":\"op\"}],\"links\":[{\"source\":3,\"target\":2},{\"source\":2,\"target\":1}]}}" } transient_issue { message: "Execution" issue_code: 1060 severity: 1 issues { position { row: 3 column: 13 } message: "Row dispatcher will use the predicate: (`data@data` IS NULL)" end_position { row: 3 column: 13 } severity: 1 } } ast { data: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (DataSource \'\"pq\" \'\"yds\"))\n(let $3 \'(\'(\'\"PartitionsCount\" \'\"1\")))\n(let $4 (DataType \'String))\n(let $5 (StructType \'(\'\"data@data\" (OptionalType $4)) \'(\'\"time\" (DataType \'Uint64))))\n(let $6 (PqTopic \'\"yds\" \'\"local\" \'\"test_filter_missing_fields_input\" $3 \'() $5))\n(let $7 \'(\'\"Endpoint\" \'\"localhost:9655\"))\n(let $8 \'(\'\"SharedReading\" \'\"1\"))\n(let $9 \'(\'\"AddBearerToToken\" \'\"1\"))\n(let $10 \'($7 $8 \'(\'\"ReconnectPeriod\" \'\"\") \'(\'\"Format\" \'\"json_each_row\") \'(\'\"ReadGroup\" \'\"ptcudq7uemfchldv1md0\") $9))\n(let $11 (SecureParam \'\"cluster:default_yds\"))\n(let $12 (DqPqTopicSource $1 $6 \'(\'\"data@data\" \'\"time\") $10 $11 \'\"2\\r\\n\\v\\x12\\tdata@data\" $5 \'\"\"))\n(let $13 (DataSink \'\"pq\" \'\"yds\"))\n(let $14 (PqTopic \'\"yds\" \'\"local\" \'\"test_filter_missing_fields_output\" $3 \'() (StructType \'(\'\"Data\" $4))))\n(let $15 (DqPqTopicSink $14 \'($7 $9) $11))\n(return (Commit! (DqQuery! $1 \'((DqStage \'((DqSource $2 $12)) (lambda \'($16) (block \'(\n  (let $17 \'(\'(\'\"format\" \'\"json_each_row\") \'(\'\"formatSettings\" \'(\'(\'\"data.datetime.formatname\" \'\"POSIX\") \'(\'\"data.timestamp.formatname\" \'\"POSIX\"))) \'(\'\"settings\" \'($8))))\n  (let $18 (DqSourceWideWrap $16 $2 $5 $17))\n  (return (FlatMap (NarrowMap $18 (lambda \'($19 $20) (AsStruct \'(\'\"data@data\" $19) \'(\'\"time\" $20)))) (lambda \'($21) (OptionalIf (Not (Exists (Member $21 \'\"data@data\"))) (AsStruct \'(\'\"column0\" (SafeCast (Member $21 \'\"time\") $4)))))))\n))) \'(\'(\'\"_logical_id\" \'200597)) \'((DqSink \'\"0\" $13 $15))))) $13))\n)\n" } } } SUCCESS
2025-12-12T12:27:31.667961Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=1/100 NOTIFY CHANGE
2025-12-12T12:27:31.668040Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:27:31.698149Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-12-12T12:27:31.754503Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 121 bytes
2025-12-12T12:27:31.754612Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
state_load_mode: FROM_LAST_CHECKPOINT
disposition {
  from_last_checkpoint {
  }
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:31.764575Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542471 nanos: 759000000 } } SUCCESS
2025-12-12T12:27:31.764615Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:32.101555Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc214, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:32.101640Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "64531345-a35ad81c-efe217e2-2072bc214"
host: "ghrun-fhkyrtz6p4"
node_id: 2
}
2025-12-12T12:27:32.104129Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:32.104156Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc214, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:32.487786Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 441 bytes
2025-12-12T12:27:32.487873Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
statistics: "{\"Graph=0\":{\"TaskRunner\":{\"Stage=200989\":{\"CpuTimeUs\":{\"sum\":\"0.00s\",\"count\":1,\"avg\":\"0.00s\",\"max\":\"0.00s\",\"min\":\"0.00s\"},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"CpuTimeUs\":{\"sum\":\"0.00s\",\"count\":1,\"avg\":\"0.00s\",\"max\":\"0.00s\",\"min\":\"0.00s\"},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}}}}"
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:32.496682Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542472 nanos: 492000000 } } SUCCESS
2025-12-12T12:27:32.496734Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:32.603927Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d83, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:32.604024Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7123ef-2eb12fc4-4f11a19c-d3f4b1d83"
host: "ghrun-fhkyrtz6p4"
node_id: 3
}
2025-12-12T12:27:32.606451Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:32.606479Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d83, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:32.625196Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741584, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:32.625257Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7b4b3e-d9d2d511-76304cae-9b3741584"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:27:32.627762Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:32.627795Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741584, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:32.689852Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7582947075894211597:2107]
2025-12-12T12:27:32.689865Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-12T12:27:32.689870Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:356: Coordinator: TEvPing received, [1:7582947075894211541:2068]
2025-12-12T12:27:32.689874Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [1:7582947075894211541:2068]
2025-12-12T12:27:32.689876Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:359: Coordinator: Send TEvPong to [1:7582947075894211541:2068]
2025-12-12T12:27:32.689886Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-12T12:27:33.101989Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc215, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:33.102043Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "64531345-a35ad81c-efe217e2-2072bc215"
host: "ghrun-fhkyrtz6p4"
node_id: 2
}
2025-12-12T12:27:33.104452Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:33.104485Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc215, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:33.488226Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 441 bytes
2025-12-12T12:27:33.488307Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
statistics: "{\"Graph=0\":{\"TaskRunner\":{\"Stage=200989\":{\"CpuTimeUs\":{\"sum\":\"0.00s\",\"count\":1,\"avg\":\"0.00s\",\"max\":\"0.00s\",\"min\":\"0.00s\"},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"CpuTimeUs\":{\"sum\":\"0.00s\",\"count\":1,\"avg\":\"0.00s\",\"max\":\"0.00s\",\"min\":\"0.00s\"},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}}}}"
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:33.497022Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542473 nanos: 492000000 } } SUCCESS
2025-12-12T12:27:33.497055Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:33.604195Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d84, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:33.604237Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7123ef-2eb12fc4-4f11a19c-d3f4b1d84"
host: "ghrun-fhkyrtz6p4"
node_id: 3
}
2025-12-12T12:27:33.606226Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:33.606258Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d84, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:33.625544Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741585, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:33.625620Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7b4b3e-d9d2d511-76304cae-9b3741585"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:27:33.627496Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:33.627548Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741585, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:33.688234Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:665: Coordinator: Change global state to Started (by timeout)
2025-12-12T12:27:34.103404Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc216, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:34.103504Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "64531345-a35ad81c-efe217e2-2072bc216"
host: "ghrun-fhkyrtz6p4"
node_id: 2
}
2025-12-12T12:27:34.106388Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:34.106456Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc216, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:34.488741Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 441 bytes
2025-12-12T12:27:34.488845Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
statistics: "{\"Graph=0\":{\"TaskRunner\":{\"Stage=200989\":{\"CpuTimeUs\":{\"sum\":\"0.00s\",\"count\":1,\"avg\":\"0.00s\",\"max\":\"0.00s\",\"min\":\"0.00s\"},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"CpuTimeUs\":{\"sum\":\"0.00s\",\"count\":1,\"avg\":\"0.00s\",\"max\":\"0.00s\",\"min\":\"0.00s\"},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}}}}"
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:34.499783Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542474 nanos: 494000000 } } SUCCESS
2025-12-12T12:27:34.499820Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:34.604772Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d85, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:34.604836Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7123ef-2eb12fc4-4f11a19c-d3f4b1d85"
host: "ghrun-fhkyrtz6p4"
node_id: 3
}
2025-12-12T12:27:34.607147Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:34.607185Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d85, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:34.624371Z :YQ_CONTROL_PLANE_STORAGE TRACE: nodes_health_check.cpp:38: NodesHealthCheckRequest: {tenant: "/compute"
node {
  node_id: 1
  instance_id: "45fb0e81-463ed951-c23c0a9b-b885eab8"
  hostname: "ghrun-fhkyrtz6p4"
  interconnect_port: 30132
  node_address: "127.0.1.1"
}
}
2025-12-12T12:27:34.625996Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741586, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:34.626060Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7b4b3e-d9d2d511-76304cae-9b3741586"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:27:34.630358Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:34.630397Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741586, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:34.636422Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: NodesHealthCheckRequest - NodesHealthCheckResult: {nodes { node_id: 1 instance_id: "45fb0e81-463ed951-c23c0a9b-b885eab8" hostname: "ghrun-fhkyrtz6p4" node_address: "127.0.1.1" } nodes { node_id: 2 instance_id: "f68ac831-41b1777a-1d35c8ae-69f4b034" hostname: "ghrun-fhkyrtz6p4" interconnect_port: 15413 node_address: "127.0.1.1" } nodes { node_id: 3 instance_id: "3997921e-406fc1c4-683e9b92-54992e12" hostname: "ghrun-fhkyrtz6p4" interconnect_port: 63718 node_address: "127.0.1.1" } } SUCCESS
2025-12-12T12:27:34.690748Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7582947075894211597:2107]
2025-12-12T12:27:34.690782Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-12T12:27:34.690781Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:356: Coordinator: TEvPing received, [1:7582947075894211541:2068]
2025-12-12T12:27:34.690791Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [1:7582947075894211541:2068]
2025-12-12T12:27:34.690793Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:359: Coordinator: Send TEvPong to [1:7582947075894211541:2068]
2025-12-12T12:27:34.690807Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-12T12:27:34.701380Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-12-12T12:27:35.102169Z :YQ_CONTROL_PLANE_STORAGE TRACE: nodes_health_check.cpp:38: NodesHealthCheckRequest: {tenant: "/compute"
node {
  node_id: 2
  instance_id: "f68ac831-41b1777a-1d35c8ae-69f4b034"
  hostname: "ghrun-fhkyrtz6p4"
  active_workers: 1
  memory_allocated: 8589934592
  interconnect_port: 15413
  node_address: "127.0.1.1"
}
}
2025-12-12T12:27:35.102966Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc217, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:35.103040Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "64531345-a35ad81c-efe217e2-2072bc217"
host: "ghrun-fhkyrtz6p4"
node_id: 2
}
2025-12-12T12:27:35.105752Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:35.105778Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc217, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:35.108716Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: NodesHealthCheckRequest - NodesHealthCheckResult: {nodes { node_id: 2 instance_id: "f68ac831-41b1777a-1d35c8ae-69f4b034" hostname: "ghrun-fhkyrtz6p4" active_workers: 1 memory_allocated: 8589934592 node_address: "127.0.1.1" } nodes { node_id: 1 instance_id: "45fb0e81-463ed951-c23c0a9b-b885eab8" hostname: "ghrun-fhkyrtz6p4" interconnect_port: 30132 node_address: "127.0.1.1" } nodes { node_id: 3 instance_id: "3997921e-406fc1c4-683e9b92-54992e12" hostname: "ghrun-fhkyrtz6p4" interconnect_port: 63718 node_address: "127.0.1.1" } } SUCCESS
2025-12-12T12:27:35.489255Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 441 bytes
2025-12-12T12:27:35.489345Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
statistics: "{\"Graph=0\":{\"TaskRunner\":{\"Stage=200989\":{\"CpuTimeUs\":{\"sum\":\"0.00s\",\"count\":1,\"avg\":\"0.00s\",\"max\":\"0.00s\",\"min\":\"0.00s\"},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"CpuTimeUs\":{\"sum\":\"0.00s\",\"count\":1,\"avg\":\"0.00s\",\"max\":\"0.00s\",\"min\":\"0.00s\"},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}}}}"
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:35.498970Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542475 nanos: 493000000 } } SUCCESS
2025-12-12T12:27:35.499013Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:35.603696Z :YQ_CONTROL_PLANE_STORAGE TRACE: nodes_health_check.cpp:38: NodesHealthCheckRequest: {tenant: "/compute"
node {
  node_id: 3
  instance_id: "3997921e-406fc1c4-683e9b92-54992e12"
  hostname: "ghrun-fhkyrtz6p4"
  interconnect_port: 63718
  node_address: "127.0.1.1"
}
}
2025-12-12T12:27:35.605115Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d86, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:35.605202Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7123ef-2eb12fc4-4f11a19c-d3f4b1d86"
host: "ghrun-fhkyrtz6p4"
node_id: 3
}
2025-12-12T12:27:35.607536Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:35.607578Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d86, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:35.610756Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: NodesHealthCheckRequest - NodesHealthCheckResult: {nodes { node_id: 3 instance_id: "3997921e-406fc1c4-683e9b92-54992e12" hostname: "ghrun-fhkyrtz6p4" node_address: "127.0.1.1" } nodes { node_id: 1 instance_id: "45fb0e81-463ed951-c23c0a9b-b885eab8" hostname: "ghrun-fhkyrtz6p4" interconnect_port: 30132 node_address: "127.0.1.1" } nodes { node_id: 2 instance_id: "f68ac831-41b1777a-1d35c8ae-69f4b034" hostname: "ghrun-fhkyrtz6p4" active_workers: 1 memory_allocated: 8589934592 interconnect_port: 15413 node_address: "127.0.1.1" } } SUCCESS
2025-12-12T12:27:35.626602Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741587, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:35.626666Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7b4b3e-d9d2d511-76304cae-9b3741587"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:27:35.628767Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:35.628802Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741587, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:36.103530Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc218, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:36.103612Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "64531345-a35ad81c-efe217e2-2072bc218"
host: "ghrun-fhkyrtz6p4"
node_id: 2
}
2025-12-12T12:27:36.105941Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:36.105978Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc218, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:36.208892Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 113 bytes
2025-12-12T12:27:36.208986Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:36.286427Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542476 nanos: 248000000 } } SUCCESS
2025-12-12T12:27:36.286459Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:36.489642Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 441 bytes
2025-12-12T12:27:36.489718Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
statistics: "{\"Graph=0\":{\"TaskRunner\":{\"Stage=200989\":{\"CpuTimeUs\":{\"sum\":\"0.00s\",\"count\":1,\"avg\":\"0.00s\",\"max\":\"0.00s\",\"min\":\"0.00s\"},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"CpuTimeUs\":{\"sum\":\"0.00s\",\"count\":1,\"avg\":\"0.00s\",\"max\":\"0.00s\",\"min\":\"0.00s\"},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}}}}"
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:36.501429Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542476 nanos: 496000000 } } SUCCESS
2025-12-12T12:27:36.501469Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:36.607335Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d87, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:36.607386Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7123ef-2eb12fc4-4f11a19c-d3f4b1d87"
host: "ghrun-fhkyrtz6p4"
node_id: 3
}
2025-12-12T12:27:36.613591Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:36.613643Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d87, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:36.626944Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741588, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:36.626994Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7b4b3e-d9d2d511-76304cae-9b3741588"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:27:36.632064Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:36.632099Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741588, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:36.691653Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7582947075894211597:2107]
2025-12-12T12:27:36.691669Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-12T12:27:36.691676Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:356: Coordinator: TEvPing received, [1:7582947075894211541:2068]
2025-12-12T12:27:36.691680Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [1:7582947075894211541:2068]
2025-12-12T12:27:36.691682Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:359: Coordinator: Send TEvPong to [1:7582947075894211541:2068]
2025-12-12T12:27:36.691687Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-12T12:27:37.107377Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc219, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:37.107438Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "64531345-a35ad81c-efe217e2-2072bc219"
host: "ghrun-fhkyrtz6p4"
node_id: 2
}
2025-12-12T12:27:37.113442Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:37.113483Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc219, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:37.491175Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 5988 bytes
2025-12-12T12:27:37.491292Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
statistics: "{\"Graph=0\":{\"TaskRunner\":{\"Sink=0\":{\"Stage=200989\":{\"EgressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"EgressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PopBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PopChunks\":{\"sum\":12,\"count\":1,\"avg\":12,\"max\":12,\"min\":12},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PushBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PushChunks\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushPauseMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushResumeMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushWaitPeriods\":{\"sum\":5,\"count\":1,\"avg\":5,\"max\":5,\"min\":5},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}},\"Stage=Total\":{\"EgressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"EgressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PopBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PopChunks\":{\"sum\":12,\"count\":1,\"avg\":12,\"max\":12,\"min\":12},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PushBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PushChunks\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushPauseMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushResumeMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushWaitPeriods\":{\"sum\":5,\"count\":1,\"avg\":5,\"max\":5,\"min\":5},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}}},\"Source=PqSource\":{\"Stage=200989\":{\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}},\"Stage=Total\":{\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}}},\"Stage=200989\":{\"BuildCpuTimeUs\":{\"sum\":\"52ms\",\"count\":1,\"avg\":\"52ms\",\"max\":\"52ms\",\"min\":\"52ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"47us\",\"count\":1,\"avg\":\"47us\",\"max\":\"47us\",\"min\":\"47us\"},\"CpuTimeUs\":{\"sum\":\"56ms\",\"count\":1,\"avg\":\"56ms\",\"max\":\"56ms\",\"min\":\"56ms\"},\"EgressRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":131072,\"count\":1,\"avg\":131072,\"max\":131072,\"min\":131072},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"BuildCpuTimeUs\":{\"sum\":\"52ms\",\"count\":1,\"avg\":\"52ms\",\"max\":\"52ms\",\"min\":\"52ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"47us\",\"count\":1,\"avg\":\"47us\",\"max\":\"47us\",\"min\":\"47us\"},\"CpuTimeUs\":{\"sum\":\"56ms\",\"count\":1,\"avg\":\"56ms\",\"max\":\"56ms\",\"min\":\"56ms\"},\"EgressRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":131072,\"count\":1,\"avg\":131072,\"max\":131072,\"min\":131072},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}}}}"
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:37.504120Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542477 nanos: 495000000 } } SUCCESS
2025-12-12T12:27:37.504157Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:37.605923Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d88, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:37.605974Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7123ef-2eb12fc4-4f11a19c-d3f4b1d88"
host: "ghrun-fhkyrtz6p4"
node_id: 3
}
2025-12-12T12:27:37.608320Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:37.608344Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d88, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:37.627417Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741589, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:37.627487Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7b4b3e-d9d2d511-76304cae-9b3741589"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:27:37.629600Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:37.629625Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b3741589, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:37.698848Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-12-12T12:27:38.104359Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc2110, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 69 bytes
2025-12-12T12:27:38.104420Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "64531345-a35ad81c-efe217e2-2072bc2110"
host: "ghrun-fhkyrtz6p4"
node_id: 2
}
2025-12-12T12:27:38.106717Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:38.106757Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc2110, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:38.491754Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 5988 bytes
2025-12-12T12:27:38.491901Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
statistics: "{\"Graph=0\":{\"TaskRunner\":{\"Sink=0\":{\"Stage=200989\":{\"EgressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"EgressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PopBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PopChunks\":{\"sum\":12,\"count\":1,\"avg\":12,\"max\":12,\"min\":12},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PushBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PushChunks\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushPauseMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushResumeMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushWaitPeriods\":{\"sum\":5,\"count\":1,\"avg\":5,\"max\":5,\"min\":5},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}},\"Stage=Total\":{\"EgressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"EgressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PopBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PopChunks\":{\"sum\":12,\"count\":1,\"avg\":12,\"max\":12,\"min\":12},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PushBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PushChunks\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushPauseMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushResumeMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushWaitPeriods\":{\"sum\":5,\"count\":1,\"avg\":5,\"max\":5,\"min\":5},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}}},\"Source=PqSource\":{\"Stage=200989\":{\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}},\"Stage=Total\":{\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}}},\"Stage=200989\":{\"BuildCpuTimeUs\":{\"sum\":\"52ms\",\"count\":1,\"avg\":\"52ms\",\"max\":\"52ms\",\"min\":\"52ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"47us\",\"count\":1,\"avg\":\"47us\",\"max\":\"47us\",\"min\":\"47us\"},\"CpuTimeUs\":{\"sum\":\"56ms\",\"count\":1,\"avg\":\"56ms\",\"max\":\"56ms\",\"min\":\"56ms\"},\"EgressRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":131072,\"count\":1,\"avg\":131072,\"max\":131072,\"min\":131072},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"BuildCpuTimeUs\":{\"sum\":\"52ms\",\"count\":1,\"avg\":\"52ms\",\"max\":\"52ms\",\"min\":\"52ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"47us\",\"count\":1,\"avg\":\"47us\",\"max\":\"47us\",\"min\":\"47us\"},\"CpuTimeUs\":{\"sum\":\"56ms\",\"count\":1,\"avg\":\"56ms\",\"max\":\"56ms\",\"min\":\"56ms\"},\"EgressRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":131072,\"count\":1,\"avg\":131072,\"max\":131072,\"min\":131072},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}}}}"
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:38.502577Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542478 nanos: 497000000 } } SUCCESS
2025-12-12T12:27:38.502608Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:38.606551Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d89, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 68 bytes
2025-12-12T12:27:38.606610Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7123ef-2eb12fc4-4f11a19c-d3f4b1d89"
host: "ghrun-fhkyrtz6p4"
node_id: 3
}
2025-12-12T12:27:38.612716Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:38.612760Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d89, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:38.627817Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b37415810, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 69 bytes
2025-12-12T12:27:38.627879Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7b4b3e-d9d2d511-76304cae-9b37415810"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:27:38.629777Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:38.629814Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b37415810, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:38.688471Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:599: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-12-12T12:27:38.688483Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:416: Coordinator: TEvUndelivered, ev: TSystem::Undelivered
2025-12-12T12:27:38.688485Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:419: Coordinator: TEvUndelivered, from nodes manager, reason: ActorUnknown
2025-12-12T12:27:38.692561Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7582947075894211597:2107]
2025-12-12T12:27:38.692578Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-12T12:27:38.692582Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:356: Coordinator: TEvPing received, [1:7582947075894211541:2068]
2025-12-12T12:27:38.692587Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [1:7582947075894211541:2068]
2025-12-12T12:27:38.692589Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:359: Coordinator: Send TEvPong to [1:7582947075894211541:2068]
2025-12-12T12:27:38.692599Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-12T12:27:39.104687Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc2111, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 69 bytes
2025-12-12T12:27:39.104747Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "64531345-a35ad81c-efe217e2-2072bc2111"
host: "ghrun-fhkyrtz6p4"
node_id: 2
}
2025-12-12T12:27:39.107366Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:39.107424Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc2111, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:39.492182Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 5988 bytes
2025-12-12T12:27:39.492325Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
statistics: "{\"Graph=0\":{\"TaskRunner\":{\"Sink=0\":{\"Stage=200989\":{\"EgressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"EgressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PopBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PopChunks\":{\"sum\":12,\"count\":1,\"avg\":12,\"max\":12,\"min\":12},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PushBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PushChunks\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushPauseMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushResumeMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushWaitPeriods\":{\"sum\":5,\"count\":1,\"avg\":5,\"max\":5,\"min\":5},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}},\"Stage=Total\":{\"EgressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"EgressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PopBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PopChunks\":{\"sum\":12,\"count\":1,\"avg\":12,\"max\":12,\"min\":12},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PushBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PushChunks\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushPauseMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushResumeMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushWaitPeriods\":{\"sum\":5,\"count\":1,\"avg\":5,\"max\":5,\"min\":5},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}}},\"Source=PqSource\":{\"Stage=200989\":{\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}},\"Stage=Total\":{\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}}},\"Stage=200989\":{\"BuildCpuTimeUs\":{\"sum\":\"52ms\",\"count\":1,\"avg\":\"52ms\",\"max\":\"52ms\",\"min\":\"52ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"47us\",\"count\":1,\"avg\":\"47us\",\"max\":\"47us\",\"min\":\"47us\"},\"CpuTimeUs\":{\"sum\":\"56ms\",\"count\":1,\"avg\":\"56ms\",\"max\":\"56ms\",\"min\":\"56ms\"},\"EgressRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":131072,\"count\":1,\"avg\":131072,\"max\":131072,\"min\":131072},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"BuildCpuTimeUs\":{\"sum\":\"52ms\",\"count\":1,\"avg\":\"52ms\",\"max\":\"52ms\",\"min\":\"52ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"47us\",\"count\":1,\"avg\":\"47us\",\"max\":\"47us\",\"min\":\"47us\"},\"CpuTimeUs\":{\"sum\":\"56ms\",\"count\":1,\"avg\":\"56ms\",\"max\":\"56ms\",\"min\":\"56ms\"},\"EgressRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":131072,\"count\":1,\"avg\":131072,\"max\":131072,\"min\":131072},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}}}}"
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:39.505063Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542479 nanos: 499000000 } } SUCCESS
2025-12-12T12:27:39.505095Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:39.607125Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d810, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 69 bytes
2025-12-12T12:27:39.607173Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7123ef-2eb12fc4-4f11a19c-d3f4b1d810"
host: "ghrun-fhkyrtz6p4"
node_id: 3
}
2025-12-12T12:27:39.609210Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:39.609268Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d810, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:39.626054Z :YQ_CONTROL_PLANE_STORAGE TRACE: nodes_health_check.cpp:38: NodesHealthCheckRequest: {tenant: "/compute"
node {
  node_id: 1
  instance_id: "45fb0e81-463ed951-c23c0a9b-b885eab8"
  hostname: "ghrun-fhkyrtz6p4"
  interconnect_port: 30132
  node_address: "127.0.1.1"
}
}
2025-12-12T12:27:39.628195Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b37415811, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 69 bytes
2025-12-12T12:27:39.628245Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7b4b3e-d9d2d511-76304cae-9b37415811"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:27:39.636066Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:39.636120Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b37415811, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:39.641227Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: NodesHealthCheckRequest - NodesHealthCheckResult: {nodes { node_id: 1 instance_id: "45fb0e81-463ed951-c23c0a9b-b885eab8" hostname: "ghrun-fhkyrtz6p4" node_address: "127.0.1.1" } nodes { node_id: 2 instance_id: "f68ac831-41b1777a-1d35c8ae-69f4b034" hostname: "ghrun-fhkyrtz6p4" active_workers: 1 memory_allocated: 8589934592 interconnect_port: 15413 node_address: "127.0.1.1" } nodes { node_id: 3 instance_id: "3997921e-406fc1c4-683e9b92-54992e12" hostname: "ghrun-fhkyrtz6p4" interconnect_port: 63718 node_address: "127.0.1.1" } } SUCCESS
2025-12-12T12:27:40.102394Z :YQ_CONTROL_PLANE_STORAGE TRACE: nodes_health_check.cpp:38: NodesHealthCheckRequest: {tenant: "/compute"
node {
  node_id: 2
  instance_id: "f68ac831-41b1777a-1d35c8ae-69f4b034"
  hostname: "ghrun-fhkyrtz6p4"
  active_workers: 1
  memory_allocated: 8589934592
  interconnect_port: 15413
  node_address: "127.0.1.1"
}
}
2025-12-12T12:27:40.105069Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc2112, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 69 bytes
2025-12-12T12:27:40.105121Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "64531345-a35ad81c-efe217e2-2072bc2112"
host: "ghrun-fhkyrtz6p4"
node_id: 2
}
2025-12-12T12:27:40.107362Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:40.107422Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc2112, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:40.108953Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: NodesHealthCheckRequest - NodesHealthCheckResult: {nodes { node_id: 2 instance_id: "f68ac831-41b1777a-1d35c8ae-69f4b034" hostname: "ghrun-fhkyrtz6p4" active_workers: 1 memory_allocated: 8589934592 node_address: "127.0.1.1" } nodes { node_id: 1 instance_id: "45fb0e81-463ed951-c23c0a9b-b885eab8" hostname: "ghrun-fhkyrtz6p4" interconnect_port: 30132 node_address: "127.0.1.1" } nodes { node_id: 3 instance_id: "3997921e-406fc1c4-683e9b92-54992e12" hostname: "ghrun-fhkyrtz6p4" interconnect_port: 63718 node_address: "127.0.1.1" } } SUCCESS
2025-12-12T12:27:40.492388Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 5988 bytes
2025-12-12T12:27:40.492515Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
statistics: "{\"Graph=0\":{\"TaskRunner\":{\"Sink=0\":{\"Stage=200989\":{\"EgressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"EgressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PopBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PopChunks\":{\"sum\":12,\"count\":1,\"avg\":12,\"max\":12,\"min\":12},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PushBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PushChunks\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushPauseMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushResumeMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushWaitPeriods\":{\"sum\":5,\"count\":1,\"avg\":5,\"max\":5,\"min\":5},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}},\"Stage=Total\":{\"EgressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"EgressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PopBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PopChunks\":{\"sum\":12,\"count\":1,\"avg\":12,\"max\":12,\"min\":12},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PushBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PushChunks\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushPauseMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushResumeMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushWaitPeriods\":{\"sum\":5,\"count\":1,\"avg\":5,\"max\":5,\"min\":5},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}}},\"Source=PqSource\":{\"Stage=200989\":{\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}},\"Stage=Total\":{\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}}},\"Stage=200989\":{\"BuildCpuTimeUs\":{\"sum\":\"52ms\",\"count\":1,\"avg\":\"52ms\",\"max\":\"52ms\",\"min\":\"52ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"47us\",\"count\":1,\"avg\":\"47us\",\"max\":\"47us\",\"min\":\"47us\"},\"CpuTimeUs\":{\"sum\":\"56ms\",\"count\":1,\"avg\":\"56ms\",\"max\":\"56ms\",\"min\":\"56ms\"},\"EgressRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":131072,\"count\":1,\"avg\":131072,\"max\":131072,\"min\":131072},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"BuildCpuTimeUs\":{\"sum\":\"52ms\",\"count\":1,\"avg\":\"52ms\",\"max\":\"52ms\",\"min\":\"52ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"47us\",\"count\":1,\"avg\":\"47us\",\"max\":\"47us\",\"min\":\"47us\"},\"CpuTimeUs\":{\"sum\":\"56ms\",\"count\":1,\"avg\":\"56ms\",\"max\":\"56ms\",\"min\":\"56ms\"},\"EgressRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":131072,\"count\":1,\"avg\":131072,\"max\":131072,\"min\":131072},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}}}}"
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:40.502509Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1765542480 nanos: 497000000 } } SUCCESS
2025-12-12T12:27:40.502543Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:40.603659Z :YQ_CONTROL_PLANE_STORAGE TRACE: nodes_health_check.cpp:38: NodesHealthCheckRequest: {tenant: "/compute"
node {
  node_id: 3
  instance_id: "3997921e-406fc1c4-683e9b92-54992e12"
  hostname: "ghrun-fhkyrtz6p4"
  interconnect_port: 63718
  node_address: "127.0.1.1"
}
}
2025-12-12T12:27:40.607432Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d811, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 69 bytes
2025-12-12T12:27:40.607501Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7123ef-2eb12fc4-4f11a19c-d3f4b1d811"
host: "ghrun-fhkyrtz6p4"
node_id: 3
}
2025-12-12T12:27:40.615425Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:40.615470Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d811, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:40.616152Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: NodesHealthCheckRequest - NodesHealthCheckResult: {nodes { node_id: 3 instance_id: "3997921e-406fc1c4-683e9b92-54992e12" hostname: "ghrun-fhkyrtz6p4" node_address: "127.0.1.1" } nodes { node_id: 1 instance_id: "45fb0e81-463ed951-c23c0a9b-b885eab8" hostname: "ghrun-fhkyrtz6p4" interconnect_port: 30132 node_address: "127.0.1.1" } nodes { node_id: 2 instance_id: "f68ac831-41b1777a-1d35c8ae-69f4b034" hostname: "ghrun-fhkyrtz6p4" active_workers: 1 memory_allocated: 8589934592 interconnect_port: 15413 node_address: "127.0.1.1" } } SUCCESS
2025-12-12T12:27:40.629059Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b37415812, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 69 bytes
2025-12-12T12:27:40.629130Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7b4b3e-d9d2d511-76304cae-9b37415812"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:27:40.635159Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:40.635194Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b37415812, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:40.693461Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7582947075894211597:2107]
2025-12-12T12:27:40.693484Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-12T12:27:40.693491Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:356: Coordinator: TEvPing received, [1:7582947075894211541:2068]
2025-12-12T12:27:40.693495Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [1:7582947075894211541:2068]
2025-12-12T12:27:40.693498Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:359: Coordinator: Send TEvPong to [1:7582947075894211541:2068]
2025-12-12T12:27:40.693503Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-12T12:27:40.701748Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-12-12T12:27:40.824028Z :TICKET_PARSER DEBUG: ticket_parser_impl.h:1875: Ticket **** (B6C6F477) (ipv6:[::1]:52218) has now valid token of root@builtin
2025-12-12T12:27:40.824126Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:1061: ControlQueryRequest: query_id: "ptqudq7uem2o5or4krva"
action: ABORT
2025-12-12T12:27:40.824169Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582947127433819441:2391]
2025-12-12T12:27:40.824193Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:27:40.824215Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582947127433819442:2392]
2025-12-12T12:27:40.824241Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:40.824252Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:27:40.824261Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:40.824275Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:27:40.828066Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:27:40.828089Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=1/100 REFRESHED
2025-12-12T12:27:40.828111Z :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:27:40.828118Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:27:40.828142Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:1061: ControlQueryRequest: query_id: "ptqudq7uem2o5or4krva"
action: ABORT
2025-12-12T12:27:40.828207Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582947127433819447:2397]
2025-12-12T12:27:40.828244Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:27:40.828268Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:1061: ControlQueryRequest: query_id: "ptqudq7uem2o5or4krva"
action: ABORT
2025-12-12T12:27:40.828300Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582947127433819448:2398]
2025-12-12T12:27:40.828358Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:1342: ControlQueryRequest: {query_id: "ptqudq7uem2o5or4krva"
action: ABORT
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:27:40.829553Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:27:40.833726Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=1/100 NOTIFY CHANGE
2025-12-12T12:27:40.833740Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:27:41.020651Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: ControlQueryRequest - ControlQueryRequest: {} SUCCESS
2025-12-12T12:27:41.022883Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7uem2o5or4krva"
2025-12-12T12:27:41.022921Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582947131728786748:2401]
2025-12-12T12:27:41.022946Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:27:41.022975Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582947131728786749:2402]
2025-12-12T12:27:41.023016Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:41.023031Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:27:41.023039Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:41.023096Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:27:41.027189Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:27:41.027214Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=1/100 REFRESHED
2025-12-12T12:27:41.027230Z :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:27:41.027237Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:27:41.027258Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7uem2o5or4krva"
2025-12-12T12:27:41.027305Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582947131728786754:2407]
2025-12-12T12:27:41.027341Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:27:41.027359Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7uem2o5or4krva"
2025-12-12T12:27:41.027378Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582947131728786755:2408]
2025-12-12T12:27:41.027423Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudq7uem2o5or4krva"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:27:41.029635Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudq7uem2o5or4krva" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1765542450 nanos: 863842000 } modified_at { seconds: 1765542460 nanos: 953234000 } revision: 2 } started_at { seconds: 1765542451 nanos: 208000000 } execute_mode: RUN status: ABORTING_BY_USER last_job_query_revision: 1 last_job_id: "ptjudq7uem2o4v3tpmvh-ptqudq7uem2o5or4krva" started_by: "root@builtin" aborted_by: "root@builtin" has_saved_checkpoints: true submitted_at { seconds: 1765542450 nanos: 863842000 } } content { type: STREAMING name: "simple" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "\n            INSERT INTO yds.`test_filter_missing_fields_output`\n            SELECT Cast(time as String) FROM yds.`test_filter_missing_fields_input`\n                WITH (format=json_each_row, SCHEMA (time UInt64 NOT NULL, `data@data` String, event String NOT NULL))\n                WHERE `data@data` IS NULL;" syntax: YQL_V1 } plan { json: "{\"Detailed\":{\"Operations\":[{\"Id\":3,\"Name\":\"DqStage\",\"Streams\":{\"Program\":[{\"Name\":\"DqSourceWideWrap\"},{\"Name\":\"NarrowMap\"},{\"Name\":\"FlatMap\"}]}},{\"Id\":2,\"Name\":\"DqQuery!\",\"DependsOn\":[3]},{\"Id\":1,\"Name\":\"Commit!\",\"DependsOn\":[2]}],\"OperationRoot\":1,\"Providers\":[],\"OperationStats\":{\"Commit!\":1,\"DqQuery!\":1,\"DqStage\":1}},\"Basic\":{\"nodes\":[{\"id\":3,\"level\":1,\"name\":\"DqStage #3\",\"type\":\"op\"},{\"id\":2,\"level\":2,\"name\":\"DqQuery!\",\"type\":\"op\"},{\"id\":1,\"level\":3,\"name\":\"Commit!\",\"type\":\"op\"}],\"links\":[{\"source\":3,\"target\":2},{\"source\":2,\"target\":1}]}}" } transient_issue { message: "Execution" issue_code: 1060 severity: 1 issues { position { row: 3 column: 13 } message: "Row dispatcher will use the predicate: (`data@data` IS NULL)" end_position { row: 3 column: 13 } severity: 1 } } statistics { json: "{\"Graph=0\":{\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"CpuTimeUs\":{\"sum\":\"56ms\",\"count\":1,\"avg\":\"56ms\",\"max\":\"56ms\",\"min\":\"56ms\"},\"EgressRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"MaxMemoryUsage\":{\"sum\":131072,\"count\":1,\"avg\":131072,\"max\":131072,\"min\":131072},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0}}}" } ast { data: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (DataSource \'\"pq\" \'\"yds\"))\n(let $3 \'(\'(\'\"PartitionsCount\" \'\"1\")))\n(let $4 (DataType \'String))\n(let $5 (StructType \'(\'\"data@data\" (OptionalType $4)) \'(\'\"time\" (DataType \'Uint64))))\n(let $6 (PqTopic \'\"yds\" \'\"local\" \'\"test_filter_missing_fields_input\" $3 \'() $5))\n(let $7 \'(\'\"Endpoint\" \'\"localhost:9655\"))\n(let $8 \'(\'\"SharedReading\" \'\"1\"))\n(let $9 \'(\'\"AddBearerToToken\" \'\"1\"))\n(let $10 \'($7 $8 \'(\'\"ReconnectPeriod\" \'\"\") \'(\'\"Format\" \'\"json_each_row\") \'(\'\"ReadGroup\" \'\"ptcudq7uemfchldv1md0\") $9))\n(let $11 (SecureParam \'\"cluster:default_yds\"))\n(let $12 (DqPqTopicSource $1 $6 \'(\'\"data@data\" \'\"time\") $10 $11 \'\"2\\r\\n\\v\\x12\\tdata@data\" $5 \'\"\"))\n(let $13 (DataSink \'\"pq\" \'\"yds\"))\n(let $14 (PqTopic \'\"yds\" \'\"local\" \'\"test_filter_missing_fields_output\" $3 \'() (StructType \'(\'\"Data\" $4))))\n(let $15 (DqPqTopicSink $14 \'($7 $9) $11))\n(return (Commit! (DqQuery! $1 \'((DqStage \'((DqSource $2 $12)) (lambda \'($16) (block \'(\n  (let $17 \'(\'(\'\"format\" \'\"json_each_row\") \'(\'\"formatSettings\" \'(\'(\'\"data.datetime.formatname\" \'\"POSIX\") \'(\'\"data.timestamp.formatname\" \'\"POSIX\"))) \'(\'\"settings\" \'($8))))\n  (let $18 (DqSourceWideWrap $16 $2 $5 $17))\n  (return (FlatMap (NarrowMap $18 (lambda \'($19 $20) (AsStruct \'(\'\"data@data\" $19) \'(\'\"time\" $20)))) (lambda \'($21) (OptionalIf (Not (Exists (Member $21 \'\"data@data\"))) (AsStruct \'(\'\"column0\" (SafeCast (Member $21 \'\"time\") $4)))))))\n))) \'(\'(\'\"_logical_id\" \'200597)) ...} SUCCESS
2025-12-12T12:27:41.032948Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:27:41.035771Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:27:41.035785Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=1/100 NOTIFY CHANGE
2025-12-12T12:27:41.107089Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc2113, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 69 bytes
2025-12-12T12:27:41.107157Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "64531345-a35ad81c-efe217e2-2072bc2113"
host: "ghrun-fhkyrtz6p4"
node_id: 2
}
2025-12-12T12:27:41.111276Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:41.111319Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 64531345-a35ad81c-efe217e2-2072bc2113, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:41.286844Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 113 bytes
2025-12-12T12:27:41.286923Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:41.293770Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {action: ABORT expired_at { seconds: 1765542481 nanos: 289000000 } } SUCCESS
2025-12-12T12:27:41.293798Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:41.294771Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 115 bytes
2025-12-12T12:27:41.294859Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
status: ABORTING_BY_USER
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:41.305500Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {action: ABORT expired_at { seconds: 1765542481 nanos: 300000000 } } SUCCESS
2025-12-12T12:27:41.305565Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:41.306589Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:175: PrivateDeleteRateLimiterResource - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::DeleteRateLimiterResource with size: 97 bytes
2025-12-12T12:27:41.306630Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: DeleteRateLimiterResourceRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
scope: "yandexcloud://my_folder"
tenant: "/compute"
} 
2025-12-12T12:27:41.341918Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: DeleteRateLimiterResourceRequest. Got response from database: SUCCESS
2025-12-12T12:27:41.342014Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run delete rate limiter resource "mock_cloud/my_folder/ptqudq7uem2o5or4krva" actor
2025-12-12T12:27:41.342020Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call delete rate limiter resource "mock_cloud/my_folder/ptqudq7uem2o5or4krva"
2025-12-12T12:27:41.344311Z :YQ_RATE_LIMITER DEBUG: schema.cpp:179: Successfully deleted rate limiter resource "mock_cloud/my_folder/ptqudq7uem2o5or4krva"
2025-12-12T12:27:41.344322Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for delete rate limiter resource "mock_cloud/my_folder/ptqudq7uem2o5or4krva": 
2025-12-12T12:27:41.344349Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:219: Got delete response from rate limiter service
2025-12-12T12:27:41.344366Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:199: PrivateDeleteRateLimiterResource - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::DeleteRateLimiterResourceResponse
2025-12-12T12:27:41.345505Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Request CP::PingTask with size: 6557 bytes
2025-12-12T12:27:41.345636Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "64531345-a35ad81c-efe217e2-2072bc212"
query_id {
  value: "ptqudq7uem2o5or4krva"
}
result_id {
  value: "ptrudq7uelo7oeq82qn2"
}
status: ABORTED_BY_USER
issues {
  message: "ABORTED_BY_USER"
  severity: 1
}
statistics: "{\"Graph=0\":{\"Actor\":{\"ActorCreateTimeUs\":{\"sum\":\"389us\",\"count\":1,\"avg\":\"389us\",\"max\":\"389us\",\"min\":\"389us\"}},\"AllocateWorkersUs\":{\"sum\":\"1ms\",\"count\":1,\"avg\":\"1ms\",\"max\":\"1ms\",\"min\":\"1ms\"},\"ExecutionTimeUs\":{\"sum\":\"9.80s\",\"count\":1,\"avg\":\"9.80s\",\"max\":\"9.80s\",\"min\":\"9.80s\"},\"TaskRunner\":{\"Sink=0\":{\"Stage=200989\":{\"EgressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"EgressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PopBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PopChunks\":{\"sum\":12,\"count\":1,\"avg\":12,\"max\":12,\"min\":12},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PushBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PushChunks\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushPauseMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushResumeMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushWaitPeriods\":{\"sum\":5,\"count\":1,\"avg\":5,\"max\":5,\"min\":5},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}},\"Stage=Total\":{\"EgressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"EgressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PopBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PopChunks\":{\"sum\":12,\"count\":1,\"avg\":12,\"max\":12,\"min\":12},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushActiveTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"},\"PushBytes\":{\"sum\":36,\"count\":1,\"avg\":36,\"max\":36,\"min\":36},\"PushChunks\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushPauseMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:31.73s\",\"max\":\"12:27:31.73s\",\"min\":\"12:27:31.73s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushResumeMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"12:27:36.60s\",\"max\":\"12:27:36.60s\",\"min\":\"12:27:36.60s\"},\"PushRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"PushWaitPeriods\":{\"sum\":5,\"count\":1,\"avg\":5,\"max\":5,\"min\":5},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}}},\"Source=PqSource\":{\"Stage=200989\":{\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}},\"Stage=Total\":{\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushWaitTimeUs\":{\"sum\":\"4.86s\",\"count\":1,\"avg\":\"4.86s\",\"max\":\"4.86s\",\"min\":\"4.86s\"}}},\"Stage=200989\":{\"BuildCpuTimeUs\":{\"sum\":\"52ms\",\"count\":1,\"avg\":\"52ms\",\"max\":\"52ms\",\"min\":\"52ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"47us\",\"count\":1,\"avg\":\"47us\",\"max\":\"47us\",\"min\":\"47us\"},\"CpuTimeUs\":{\"sum\":\"56ms\",\"count\":1,\"avg\":\"56ms\",\"max\":\"56ms\",\"min\":\"56ms\"},\"EgressRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":131072,\"count\":1,\"avg\":131072,\"max\":131072,\"min\":131072},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"BuildCpuTimeUs\":{\"sum\":\"52ms\",\"count\":1,\"avg\":\"52ms\",\"max\":\"52ms\",\"min\":\"52ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"47us\",\"count\":1,\"avg\":\"47us\",\"max\":\"47us\",\"min\":\"47us\"},\"CpuTimeUs\":{\"sum\":\"56ms\",\"count\":1,\"avg\":\"56ms\",\"max\":\"56ms\",\"min\":\"56ms\"},\"EgressRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":131072,\"count\":1,\"avg\":131072,\"max\":131072,\"min\":131072},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}},\"UniqueWorkers\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}}"
resources {
  rate_limiter: READY
  compilation: READY
  topic_consumers_state: READY
  rate_limiter_path: "local/RateLimiter_e0c8d7ba-1543-4913-8d1e-1a9eb9bae724/rate_limiter"
  topic_consumers {
    database: "local"
    topic_path: "test_filter_missing_fields_input"
    consumer_name: "ptqudq7uem2o5or4krva"
    cluster_endpoint: "localhost:9655"
    token_name: "cluster:default_yds"
    add_bearer_to_token: true
  }
}
scope: "yandexcloud://my_folder"
finished_at {
  seconds: 1765542461
  nanos: 294000000
}
deadline {
  seconds: 1765628851
  nanos: 151684000
}
tenant: "/compute"
}
2025-12-12T12:27:41.421843Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {action: ABORT } SUCCESS
2025-12-12T12:27:41.421883Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudq7uem2o5or4krva, Owner: 64531345-a35ad81c-efe217e2-2072bc212, Got CP::PingTaskResponse
2025-12-12T12:27:41.531966Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7uem2o5or4krva"
2025-12-12T12:27:41.532003Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582947131728786776:2428]
2025-12-12T12:27:41.532035Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:27:41.532055Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582947131728786777:2429]
2025-12-12T12:27:41.532079Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:41.532095Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:27:41.532104Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:41.532115Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:27:41.533967Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:27:41.533982Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=0/100 REFRESHED
2025-12-12T12:27:41.534003Z :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:27:41.534014Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:27:41.534059Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7uem2o5or4krva"
2025-12-12T12:27:41.534099Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582947131728786782:2434]
2025-12-12T12:27:41.534132Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:27:41.534152Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7uem2o5or4krva"
2025-12-12T12:27:41.534170Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582947131728786783:2435]
2025-12-12T12:27:41.534223Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudq7uem2o5or4krva"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:27:41.536502Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudq7uem2o5or4krva" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1765542450 nanos: 863842000 } modified_at { seconds: 1765542460 nanos: 953234000 } revision: 2 } started_at { seconds: 1765542451 nanos: 208000000 } finished_at { seconds: 1765542461 nanos: 294000000 } execute_mode: RUN status: ABORTED_BY_USER last_job_query_revision: 1 last_job_id: "ptjudq7uem2o4v3tpmvh-ptqudq7uem2o5or4krva" started_by: "root@builtin" aborted_by: "root@builtin" has_saved_checkpoints: true submitted_at { seconds: 1765542450 nanos: 863842000 } } content { type: STREAMING name: "simple" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "\n            INSERT INTO yds.`test_filter_missing_fields_output`\n            SELECT Cast(time as String) FROM yds.`test_filter_missing_fields_input`\n                WITH (format=json_each_row, SCHEMA (time UInt64 NOT NULL, `data@data` String, event String NOT NULL))\n                WHERE `data@data` IS NULL;" syntax: YQL_V1 } plan { json: "{\"Detailed\":{\"Operations\":[{\"Id\":3,\"Name\":\"DqStage\",\"Streams\":{\"Program\":[{\"Name\":\"DqSourceWideWrap\"},{\"Name\":\"NarrowMap\"},{\"Name\":\"FlatMap\"}]}},{\"Id\":2,\"Name\":\"DqQuery!\",\"DependsOn\":[3]},{\"Id\":1,\"Name\":\"Commit!\",\"DependsOn\":[2]}],\"OperationRoot\":1,\"Providers\":[],\"OperationStats\":{\"Commit!\":1,\"DqQuery!\":1,\"DqStage\":1}},\"Basic\":{\"nodes\":[{\"id\":3,\"level\":1,\"name\":\"DqStage #3\",\"type\":\"op\"},{\"id\":2,\"level\":2,\"name\":\"DqQuery!\",\"type\":\"op\"},{\"id\":1,\"level\":3,\"name\":\"Commit!\",\"type\":\"op\"}],\"links\":[{\"source\":3,\"target\":2},{\"source\":2,\"target\":1}]}}" } issue { message: "ABORTED_BY_USER" severity: 1 } transient_issue { message: "Execution" issue_code: 1060 severity: 1 issues { position { row: 3 column: 13 } message: "Row dispatcher will use the predicate: (`data@data` IS NULL)" end_position { row: 3 column: 13 } severity: 1 } } statistics { json: "{\"Graph=0\":{\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"CpuTimeUs\":{\"sum\":\"56ms\",\"count\":1,\"avg\":\"56ms\",\"max\":\"56ms\",\"min\":\"56ms\"},\"EgressRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"MaxMemoryUsage\":{\"sum\":131072,\"count\":1,\"avg\":131072,\"max\":131072,\"min\":131072},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0}}}" } ast { data: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (DataSource \'\"pq\" \'\"yds\"))\n(let $3 \'(\'(\'\"PartitionsCount\" \'\"1\")))\n(let $4 (DataType \'String))\n(let $5 (StructType \'(\'\"data@data\" (OptionalType $4)) \'(\'\"time\" (DataType \'Uint64))))\n(let $6 (PqTopic \'\"yds\" \'\"local\" \'\"test_filter_missing_fields_input\" $3 \'() $5))\n(let $7 \'(\'\"Endpoint\" \'\"localhost:9655\"))\n(let $8 \'(\'\"SharedReading\" \'\"1\"))\n(let $9 \'(\'\"AddBearerToToken\" \'\"1\"))\n(let $10 \'($7 $8 \'(\'\"ReconnectPeriod\" \'\"\") \'(\'\"Format\" \'\"json_each_row\") \'(\'\"ReadGroup\" \'\"ptcudq7uemfchldv1md0\") $9))\n(let $11 (SecureParam \'\"cluster:default_yds\"))\n(let $12 (DqPqTopicSource $1 $6 \'(\'\"data@data\" \'\"time\") $10 $11 \'\"2\\r\\n\\v\\x12\\tdata@data\" $5 \'\"\"))\n(let $13 (DataSink \'\"pq\" \'\"yds\"))\n(let $14 (PqTopic \'\"yds\" \'\"local\" \'\"test_filter_missing_fields_output\" $3 \'() (StructType \'(\'\"Data\" $4))))\n(let $15 (DqPqTopicSink $14 \'($7 $9) $11))\n(return (Commit! (DqQuery! $1 \'((DqStage \'((DqSource $2 $12)) (lambda \'($16) (block \'(\n  (let $17 \'(\'(\'\"format\" \'\"json_each_row\") \'(\'\"formatSettings\" \'(\'(\'\"data.datetime.formatname\" \'\"POSIX\") \'(\'\"data.timestamp.formatname\" \'\"POSIX\"))) \'(\'\"settings\" \'($8))))\n  (let $18 (DqSourceWideWrap $16 $2 $5 $17))\n  (return (FlatMap (NarrowMap $18 (lambda \'($19 $20) (AsStruct \'(\'\"data@data\" $19) \'(\'\"time\" $20)))) (lambda \'($21) (OptionalIf (Not (Exists (Member $21 \'\"data@data\"))) (AsStruct ...} SUCCESS
2025-12-12T12:27:41.537043Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:27:41.538772Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7uem2o5or4krva"
2025-12-12T12:27:41.538813Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:305: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7582947131728786787:2438]
2025-12-12T12:27:41.538834Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:367: Cloud id: mock_cloud Folder id: my_folder
2025-12-12T12:27:41.538848Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:91: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7582947131728786788:2439]
2025-12-12T12:27:41.538864Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:41.538872Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-12-12T12:27:41.538880Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-12-12T12:27:41.538890Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-12-12T12:27:41.540174Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:27:41.540452Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:27:41.540484Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-12-12T12:27:41.540502Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:707: cloud.mock_cloud.yq.streamingQuery.count=0/100 REFRESHED
2025-12-12T12:27:41.540517Z :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:27:41.540528Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:103: Cloud id: mock_cloud Quota count: 8
2025-12-12T12:27:41.540544Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7uem2o5or4krva"
2025-12-12T12:27:41.540587Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:169: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7582947131728786793:2444]
2025-12-12T12:27:41.540619Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:230: Subject Type: federated_account Token: **** (B6C6F477)
2025-12-12T12:27:41.540644Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:784: DescribeQueryRequest: query_id: "ptqudq7uem2o5or4krva"
2025-12-12T12:27:41.540671Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:63: Request actor. Actor id: [1:7582947131728786794:2445]
2025-12-12T12:27:41.540714Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudq7uem2o5or4krva"
} [root@builtin, **** (B6C6F477)] 
2025-12-12T12:27:41.542396Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudq7uem2o5or4krva" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1765542450 nanos: 863842000 } modified_at { seconds: 1765542460 nanos: 953234000 } revision: 2 } started_at { seconds: 1765542451 nanos: 208000000 } finished_at { seconds: 1765542461 nanos: 294000000 } execute_mode: RUN status: ABORTED_BY_USER last_job_query_revision: 1 last_job_id: "ptjudq7uem2o4v3tpmvh-ptqudq7uem2o5or4krva" started_by: "root@builtin" aborted_by: "root@builtin" has_saved_checkpoints: true submitted_at { seconds: 1765542450 nanos: 863842000 } } content { type: STREAMING name: "simple" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "\n            INSERT INTO yds.`test_filter_missing_fields_output`\n            SELECT Cast(time as String) FROM yds.`test_filter_missing_fields_input`\n                WITH (format=json_each_row, SCHEMA (time UInt64 NOT NULL, `data@data` String, event String NOT NULL))\n                WHERE `data@data` IS NULL;" syntax: YQL_V1 } plan { json: "{\"Detailed\":{\"Operations\":[{\"Id\":3,\"Name\":\"DqStage\",\"Streams\":{\"Program\":[{\"Name\":\"DqSourceWideWrap\"},{\"Name\":\"NarrowMap\"},{\"Name\":\"FlatMap\"}]}},{\"Id\":2,\"Name\":\"DqQuery!\",\"DependsOn\":[3]},{\"Id\":1,\"Name\":\"Commit!\",\"DependsOn\":[2]}],\"OperationRoot\":1,\"Providers\":[],\"OperationStats\":{\"Commit!\":1,\"DqQuery!\":1,\"DqStage\":1}},\"Basic\":{\"nodes\":[{\"id\":3,\"level\":1,\"name\":\"DqStage #3\",\"type\":\"op\"},{\"id\":2,\"level\":2,\"name\":\"DqQuery!\",\"type\":\"op\"},{\"id\":1,\"level\":3,\"name\":\"Commit!\",\"type\":\"op\"}],\"links\":[{\"source\":3,\"target\":2},{\"source\":2,\"target\":1}]}}" } issue { message: "ABORTED_BY_USER" severity: 1 } transient_issue { message: "Execution" issue_code: 1060 severity: 1 issues { position { row: 3 column: 13 } message: "Row dispatcher will use the predicate: (`data@data` IS NULL)" end_position { row: 3 column: 13 } severity: 1 } } statistics { json: "{\"Graph=0\":{\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"CpuTimeUs\":{\"sum\":\"56ms\",\"count\":1,\"avg\":\"56ms\",\"max\":\"56ms\",\"min\":\"56ms\"},\"EgressRows\":{\"sum\":6,\"count\":1,\"avg\":6,\"max\":6,\"min\":6},\"MaxMemoryUsage\":{\"sum\":131072,\"count\":1,\"avg\":131072,\"max\":131072,\"min\":131072},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0}}}" } ast { data: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (DataSource \'\"pq\" \'\"yds\"))\n(let $3 \'(\'(\'\"PartitionsCount\" \'\"1\")))\n(let $4 (DataType \'String))\n(let $5 (StructType \'(\'\"data@data\" (OptionalType $4)) \'(\'\"time\" (DataType \'Uint64))))\n(let $6 (PqTopic \'\"yds\" \'\"local\" \'\"test_filter_missing_fields_input\" $3 \'() $5))\n(let $7 \'(\'\"Endpoint\" \'\"localhost:9655\"))\n(let $8 \'(\'\"SharedReading\" \'\"1\"))\n(let $9 \'(\'\"AddBearerToToken\" \'\"1\"))\n(let $10 \'($7 $8 \'(\'\"ReconnectPeriod\" \'\"\") \'(\'\"Format\" \'\"json_each_row\") \'(\'\"ReadGroup\" \'\"ptcudq7uemfchldv1md0\") $9))\n(let $11 (SecureParam \'\"cluster:default_yds\"))\n(let $12 (DqPqTopicSource $1 $6 \'(\'\"data@data\" \'\"time\") $10 $11 \'\"2\\r\\n\\v\\x12\\tdata@data\" $5 \'\"\"))\n(let $13 (DataSink \'\"pq\" \'\"yds\"))\n(let $14 (PqTopic \'\"yds\" \'\"local\" \'\"test_filter_missing_fields_output\" $3 \'() (StructType \'(\'\"Data\" $4))))\n(let $15 (DqPqTopicSink $14 \'($7 $9) $11))\n(return (Commit! (DqQuery! $1 \'((DqStage \'((DqSource $2 $12)) (lambda \'($16) (block \'(\n  (let $17 \'(\'(\'\"format\" \'\"json_each_row\") \'(\'\"formatSettings\" \'(\'(\'\"data.datetime.formatname\" \'\"POSIX\") \'(\'\"data.timestamp.formatname\" \'\"POSIX\"))) \'(\'\"settings\" \'($8))))\n  (let $18 (DqSourceWideWrap $16 $2 $5 $17))\n  (return (FlatMap (NarrowMap $18 (lambda \'($19 $20) (AsStruct \'(\'\"data@data\" $19) \'(\'\"time\" $20)))) (lambda \'($21) (OptionalIf (Not (Exists (Member $21 \'\"data@data\"))) (AsStruct ...} SUCCESS
2025-12-12T12:27:41.544324Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-12-12T12:27:41.544397Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:27:41.545020Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=0/100 NOTIFY CHANGE
2025-12-12T12:27:41.611327Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d812, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 69 bytes
2025-12-12T12:27:41.611406Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7123ef-2eb12fc4-4f11a19c-d3f4b1d812"
host: "ghrun-fhkyrtz6p4"
node_id: 3
}
2025-12-12T12:27:41.613924Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:41.613969Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7123ef-2eb12fc4-4f11a19c-d3f4b1d812, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
2025-12-12T12:27:41.629222Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b37415813, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Request CP::GetTask with size: 69 bytes
2025-12-12T12:27:41.629273Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/compute"
owner_id: "4c7b4b3e-d9d2d511-76304cae-9b37415813"
host: "ghrun-fhkyrtz6p4"
node_id: 1
}
2025-12-12T12:27:41.631470Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-12-12T12:27:41.631515Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 4c7b4b3e-d9d2d511-76304cae-9b37415813, Host: ghrun-fhkyrtz6p4, Tenant: /compute, Got CP::GetTask Response
